Oct 19 09:02:33.723628 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Oct 19 09:02:33.723683 kernel: Linux version 6.18.45-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 15.3.0 p8) 15.3.0, GNU ld (Gentoo 2.46.1 p1) 2.46.1) #1 SMP PREEMPT Mon Oct 19 06:51:01 -00 2026 Oct 19 09:02:33.723703 kernel: KASLR disabled due to lack of seed Oct 19 09:02:33.723718 kernel: efi: EFI v2.7 by EDK II Oct 19 09:02:33.723735 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7a5f1a98 MEMRESERVE=0x78551b98 Oct 19 09:02:33.723754 kernel: secureboot: Secure boot disabled Oct 19 09:02:33.723772 kernel: ACPI: Early table checksum verification disabled Oct 19 09:02:33.723787 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Oct 19 09:02:33.723803 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Oct 19 09:02:33.723818 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Oct 19 09:02:33.723834 kernel: ACPI: DSDT 0x0000000078640000 0013D2 (v02 AMAZON AMZNDSDT 00000001 AMZN 00000001) Oct 19 09:02:33.723849 kernel: ACPI: FACS 0x0000000078630000 000040 Oct 19 09:02:33.723864 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Oct 19 09:02:33.723884 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Oct 19 09:02:33.723902 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Oct 19 09:02:33.723918 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Oct 19 09:02:33.723935 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Oct 19 09:02:33.723955 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Oct 19 09:02:33.727065 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Oct 19 09:02:33.727086 kernel: ACPI: SPCR: console: uart,mmio,0x80000000,115200 Oct 19 09:02:33.727103 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Oct 19 09:02:33.727188 kernel: NODE_DATA(0) allocated [mem 0x4b584fa00-0x4b5856fff] Oct 19 09:02:33.727210 kernel: Zone ranges: Oct 19 09:02:33.727229 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Oct 19 09:02:33.727246 kernel: DMA32 empty Oct 19 09:02:33.727262 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Oct 19 09:02:33.727279 kernel: Device empty Oct 19 09:02:33.727295 kernel: Movable zone start for each node Oct 19 09:02:33.727325 kernel: Early memory node ranges Oct 19 09:02:33.727342 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Oct 19 09:02:33.727359 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Oct 19 09:02:33.727377 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Oct 19 09:02:33.727394 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Oct 19 09:02:33.727410 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Oct 19 09:02:33.727427 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Oct 19 09:02:33.727446 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Oct 19 09:02:33.727462 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Oct 19 09:02:33.727478 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Oct 19 09:02:33.727494 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Oct 19 09:02:33.727511 kernel: cma: Reserved 16 MiB at 0x000000007f000000 Oct 19 09:02:33.727540 kernel: psci: probing for conduit method from ACPI. Oct 19 09:02:33.727557 kernel: psci: PSCIv1.0 detected in firmware. Oct 19 09:02:33.727574 kernel: psci: Using standard PSCI v0.2 function IDs Oct 19 09:02:33.727596 kernel: psci: Trusted OS migration not required Oct 19 09:02:33.727613 kernel: psci: SMC Calling Convention v1.1 Oct 19 09:02:33.727630 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Oct 19 09:02:33.727647 kernel: percpu: Embedded 34 pages/cpu s99608 r8192 d31464 u139264 Oct 19 09:02:33.727664 kernel: pcpu-alloc: s99608 r8192 d31464 u139264 alloc=34*4096 Oct 19 09:02:33.727681 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 19 09:02:33.727698 kernel: Detected PIPT I-cache on CPU0 Oct 19 09:02:33.727715 kernel: CPU features: detected: GICv3 CPU interface Oct 19 09:02:33.727731 kernel: CPU features: detected: Spectre-v2 Oct 19 09:02:33.727748 kernel: CPU features: detected: Spectre-v3a Oct 19 09:02:33.727764 kernel: CPU features: detected: Spectre-BHB Oct 19 09:02:33.727786 kernel: CPU features: detected: ARM erratum 1742098 Oct 19 09:02:33.727803 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Oct 19 09:02:33.727821 kernel: alternatives: applying boot alternatives Oct 19 09:02:33.727842 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 flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=f1f52c5d7d8fc22fc51e600c3f4777f00e7bd5639af44f451541d366f3a93d64 Oct 19 09:02:33.727861 kernel: printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes Oct 19 09:02:33.727878 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 19 09:02:33.727895 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 19 09:02:33.727913 kernel: software IO TLB: area num 2. Oct 19 09:02:33.727930 kernel: software IO TLB: mapped [mem 0x0000000074530000-0x0000000078530000] (64MB) Oct 19 09:02:33.727953 kernel: Fallback order for Node 0: 0 Oct 19 09:02:33.728040 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1007616 Oct 19 09:02:33.728063 kernel: Policy zone: Normal Oct 19 09:02:33.728081 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 19 09:02:33.728099 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 19 09:02:33.728116 kernel: ftrace: allocating 43121 entries in 170 pages Oct 19 09:02:33.728133 kernel: ftrace: allocated 170 pages with 4 groups Oct 19 09:02:33.728149 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 19 09:02:33.728168 kernel: rcu: RCU event tracing is enabled. Oct 19 09:02:33.728186 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 19 09:02:33.728203 kernel: Trampoline variant of Tasks RCU enabled. Oct 19 09:02:33.728220 kernel: Rude variant of Tasks RCU enabled. Oct 19 09:02:33.728249 kernel: Tracing variant of Tasks RCU enabled. Oct 19 09:02:33.728266 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 19 09:02:33.728283 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 19 09:02:33.728300 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 19 09:02:33.728317 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 19 09:02:33.728334 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 19 09:02:33.728352 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 19 09:02:33.728368 kernel: GICv3: 96 SPIs implemented Oct 19 09:02:33.728386 kernel: GICv3: 0 Extended SPIs implemented Oct 19 09:02:33.728403 kernel: Root IRQ handler: gic_handle_irq Oct 19 09:02:33.728420 kernel: GICv3: GICv3 features: 16 PPIs Oct 19 09:02:33.728443 kernel: GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 Oct 19 09:02:33.728461 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Oct 19 09:02:33.728478 kernel: ITS [mem 0x10080000-0x1009ffff] Oct 19 09:02:33.728496 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4001a0000 (indirect, esz 8, psz 64K, shr 1) Oct 19 09:02:33.728514 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4001b0000 (flat, esz 8, psz 64K, shr 1) Oct 19 09:02:33.728531 kernel: GICv3: using LPI property table @0x00000004001c0000 Oct 19 09:02:33.728549 kernel: ITS: Using hypervisor restricted LPI range [128] Oct 19 09:02:33.728566 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004001d0000 Oct 19 09:02:33.728583 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 19 09:02:33.728600 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 19 09:02:33.728617 kernel: arch_timer: cp15 timer running at 83.33MHz (virt). Oct 19 09:02:33.728640 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Oct 19 09:02:33.728657 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Oct 19 09:02:33.728675 kernel: Console: colour dummy device 80x25 Oct 19 09:02:33.728694 kernel: printk: legacy console [tty1] enabled Oct 19 09:02:33.728712 kernel: ACPI: Core revision 20250807 Oct 19 09:02:33.728731 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Oct 19 09:02:33.728748 kernel: pid_max: default: 32768 minimum: 301 Oct 19 09:02:33.728766 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 19 09:02:33.728789 kernel: landlock: Up and running. Oct 19 09:02:33.728807 kernel: SELinux: Initializing. Oct 19 09:02:33.728825 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 19 09:02:33.728843 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 19 09:02:33.728861 kernel: rcu: Hierarchical SRCU implementation. Oct 19 09:02:33.728880 kernel: rcu: Max phase no-delay instances is 400. Oct 19 09:02:33.728897 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 19 09:02:33.728920 kernel: Remapping and enabling EFI services. Oct 19 09:02:33.728938 kernel: smp: Bringing up secondary CPUs ... Oct 19 09:02:33.728955 kernel: Detected PIPT I-cache on CPU1 Oct 19 09:02:33.729839 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Oct 19 09:02:33.729860 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004001e0000 Oct 19 09:02:33.729879 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Oct 19 09:02:33.729918 kernel: smp: Brought up 1 node, 2 CPUs Oct 19 09:02:33.729937 kernel: SMP: Total of 2 processors activated. Oct 19 09:02:33.729956 kernel: CPU: All CPU(s) started at EL1 Oct 19 09:02:33.730006 kernel: CPU features: detected: 32-bit EL0 Support Oct 19 09:02:33.730035 kernel: CPU features: detected: 32-bit EL1 Support Oct 19 09:02:33.730054 kernel: CPU features: detected: CRC32 instructions Oct 19 09:02:33.730073 kernel: CPU features: detected: PMUv3 Oct 19 09:02:33.730096 kernel: alternatives: applying system-wide alternatives Oct 19 09:02:33.730117 kernel: Memory: 3818496K/4030464K available (13248K kernel code, 2506K rwdata, 9996K rodata, 13568K init, 984K bss, 189812K reserved, 16384K cma-reserved) Oct 19 09:02:33.730136 kernel: devtmpfs: initialized Oct 19 09:02:33.730154 kernel: posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) Oct 19 09:02:33.730173 kernel: futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). Oct 19 09:02:33.730191 kernel: 22624 pages in range for non-PLT usage Oct 19 09:02:33.730209 kernel: 514144 pages in range for PLT usage Oct 19 09:02:33.730232 kernel: pinctrl core: initialized pinctrl subsystem Oct 19 09:02:33.730251 kernel: SMBIOS 3.0.0 present. Oct 19 09:02:33.730269 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Oct 19 09:02:33.730288 kernel: DMI: Memory slots populated: 0/0 Oct 19 09:02:33.730306 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 19 09:02:33.730324 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 19 09:02:33.730343 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 19 09:02:33.730361 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 19 09:02:33.730385 kernel: audit: initializing netlink subsys (disabled) Oct 19 09:02:33.730403 kernel: audit: type=2000 audit(0.280:1): state=initialized audit_enabled=0 res=1 Oct 19 09:02:33.730421 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 19 09:02:33.730439 kernel: cpuidle: using governor menu Oct 19 09:02:33.730457 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 19 09:02:33.730475 kernel: ASID allocator initialised with 65536 entries Oct 19 09:02:33.730494 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 19 09:02:33.730516 kernel: Serial: AMBA PL011 UART driver Oct 19 09:02:33.730535 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 19 09:02:33.730553 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 19 09:02:33.730571 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 19 09:02:33.730590 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 19 09:02:33.730608 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 19 09:02:33.730626 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 19 09:02:33.730650 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 19 09:02:33.730668 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 19 09:02:33.730686 kernel: ACPI: Added _OSI(Module Device) Oct 19 09:02:33.730705 kernel: ACPI: Added _OSI(Processor Device) Oct 19 09:02:33.730723 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 19 09:02:33.730741 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 19 09:02:33.730760 kernel: ACPI: Interpreter enabled Oct 19 09:02:33.730783 kernel: ACPI: Using GIC for interrupt routing Oct 19 09:02:33.730802 kernel: ACPI: MCFG table detected, 1 entries Oct 19 09:02:33.730820 kernel: ACPI: CPU0 has been hot-added Oct 19 09:02:33.730838 kernel: ACPI: CPU1 has been hot-added Oct 19 09:02:33.730856 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00]) Oct 19 09:02:33.731387 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 19 09:02:33.731717 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 19 09:02:33.732275 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 19 09:02:33.732734 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x200fffff] reserved by PNP0C02:00 Oct 19 09:02:33.733108 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x200fffff] for [bus 00] Oct 19 09:02:33.733138 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Oct 19 09:02:33.733158 kernel: acpiphp: Slot [1] registered Oct 19 09:02:33.733177 kernel: acpiphp: Slot [2] registered Oct 19 09:02:33.733205 kernel: acpiphp: Slot [3] registered Oct 19 09:02:33.733224 kernel: acpiphp: Slot [4] registered Oct 19 09:02:33.733241 kernel: acpiphp: Slot [5] registered Oct 19 09:02:33.733260 kernel: acpiphp: Slot [6] registered Oct 19 09:02:33.733278 kernel: acpiphp: Slot [7] registered Oct 19 09:02:33.733295 kernel: acpiphp: Slot [8] registered Oct 19 09:02:33.733314 kernel: acpiphp: Slot [9] registered Oct 19 09:02:33.733337 kernel: acpiphp: Slot [10] registered Oct 19 09:02:33.733356 kernel: acpiphp: Slot [11] registered Oct 19 09:02:33.733377 kernel: acpiphp: Slot [12] registered Oct 19 09:02:33.733395 kernel: acpiphp: Slot [13] registered Oct 19 09:02:33.733413 kernel: acpiphp: Slot [14] registered Oct 19 09:02:33.733431 kernel: acpiphp: Slot [15] registered Oct 19 09:02:33.733449 kernel: acpiphp: Slot [16] registered Oct 19 09:02:33.733467 kernel: acpiphp: Slot [17] registered Oct 19 09:02:33.733491 kernel: acpiphp: Slot [18] registered Oct 19 09:02:33.733509 kernel: acpiphp: Slot [19] registered Oct 19 09:02:33.733527 kernel: acpiphp: Slot [20] registered Oct 19 09:02:33.733545 kernel: acpiphp: Slot [21] registered Oct 19 09:02:33.733562 kernel: acpiphp: Slot [22] registered Oct 19 09:02:33.733581 kernel: acpiphp: Slot [23] registered Oct 19 09:02:33.733599 kernel: acpiphp: Slot [24] registered Oct 19 09:02:33.733621 kernel: acpiphp: Slot [25] registered Oct 19 09:02:33.733640 kernel: acpiphp: Slot [26] registered Oct 19 09:02:33.733658 kernel: acpiphp: Slot [27] registered Oct 19 09:02:33.733677 kernel: acpiphp: Slot [28] registered Oct 19 09:02:33.733695 kernel: acpiphp: Slot [29] registered Oct 19 09:02:33.733714 kernel: acpiphp: Slot [30] registered Oct 19 09:02:33.733732 kernel: acpiphp: Slot [31] registered Oct 19 09:02:33.733755 kernel: PCI host bridge to bus 0000:00 Oct 19 09:02:33.734176 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Oct 19 09:02:33.734484 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 19 09:02:33.734766 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Oct 19 09:02:33.739910 kernel: pci_bus 0000:00: root bus resource [bus 00] Oct 19 09:02:33.740353 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 conventional PCI endpoint Oct 19 09:02:33.740719 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 conventional PCI endpoint Oct 19 09:02:33.743214 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff] Oct 19 09:02:33.743626 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 PCIe Root Complex Integrated Endpoint Oct 19 09:02:33.744020 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80114000-0x80117fff] Oct 19 09:02:33.744384 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 19 09:02:33.744773 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 PCIe Root Complex Integrated Endpoint Oct 19 09:02:33.746129 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80110000-0x80113fff] Oct 19 09:02:33.746502 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref] Oct 19 09:02:33.746801 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff] Oct 19 09:02:33.747205 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 19 09:02:33.747506 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Oct 19 09:02:33.747805 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 19 09:02:33.748146 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Oct 19 09:02:33.748181 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 19 09:02:33.748202 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 19 09:02:33.748223 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 19 09:02:33.748242 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 19 09:02:33.748261 kernel: iommu: Default domain type: Translated Oct 19 09:02:33.748293 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 19 09:02:33.748313 kernel: efivars: Registered efivars operations Oct 19 09:02:33.748332 kernel: vgaarb: loaded Oct 19 09:02:33.748350 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 19 09:02:33.748369 kernel: VFS: Disk quotas dquot_6.6.0 Oct 19 09:02:33.748389 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 19 09:02:33.748407 kernel: pnp: PnP ACPI init Oct 19 09:02:33.748764 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Oct 19 09:02:33.748801 kernel: pnp: PnP ACPI: found 1 devices Oct 19 09:02:33.748821 kernel: NET: Registered PF_INET protocol family Oct 19 09:02:33.748840 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 19 09:02:33.748858 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 19 09:02:33.748877 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 19 09:02:33.748906 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 19 09:02:33.748926 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 19 09:02:33.748944 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 19 09:02:33.752291 kernel: UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) Oct 19 09:02:33.752339 kernel: UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) Oct 19 09:02:33.752360 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 19 09:02:33.752379 kernel: PCI: CLS 0 bytes, default 64 Oct 19 09:02:33.752413 kernel: kvm [1]: HYP mode not available Oct 19 09:02:33.752432 kernel: Initialise system trusted keyrings Oct 19 09:02:33.752451 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 19 09:02:33.752469 kernel: Key type asymmetric registered Oct 19 09:02:33.752487 kernel: Asymmetric key parser 'x509' registered Oct 19 09:02:33.752505 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) Oct 19 09:02:33.752523 kernel: io scheduler mq-deadline registered Oct 19 09:02:33.752546 kernel: io scheduler kyber registered Oct 19 09:02:33.752564 kernel: io scheduler bfq registered Oct 19 09:02:33.753053 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Oct 19 09:02:33.753098 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 19 09:02:33.753117 kernel: ACPI: button: Power Button [PWRB] Oct 19 09:02:33.753137 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Oct 19 09:02:33.753156 kernel: ACPI: button: Sleep Button [SLPB] Oct 19 09:02:33.753187 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 19 09:02:33.753207 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Oct 19 09:02:33.753562 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Oct 19 09:02:33.753594 kernel: printk: legacy console [ttyS0] disabled Oct 19 09:02:33.753614 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Oct 19 09:02:33.753632 kernel: printk: legacy console [ttyS0] enabled Oct 19 09:02:33.753651 kernel: ACPI: bus type drm_connector registered Oct 19 09:02:33.753682 kernel: thunder_xcv, ver 1.0 Oct 19 09:02:33.753701 kernel: thunder_bgx, ver 1.0 Oct 19 09:02:33.753719 kernel: nicpf, ver 1.0 Oct 19 09:02:33.753738 kernel: nicvf, ver 1.0 Oct 19 09:02:33.759185 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 19 09:02:33.759556 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-10-19T09:02:28 UTC (1792400548) Oct 19 09:02:33.759595 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 19 09:02:33.759626 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 (0,80000003) counters available Oct 19 09:02:33.759646 kernel: watchdog: NMI not fully supported Oct 19 09:02:33.759667 kernel: NET: Registered PF_INET6 protocol family Oct 19 09:02:33.759688 kernel: watchdog: Hard watchdog permanently disabled Oct 19 09:02:33.759707 kernel: Segment Routing with IPv6 Oct 19 09:02:33.759726 kernel: In-situ OAM (IOAM) with IPv6 Oct 19 09:02:33.759746 kernel: NET: Registered PF_PACKET protocol family Oct 19 09:02:33.759771 kernel: Key type dns_resolver registered Oct 19 09:02:33.759790 kernel: registered taskstats version 1 Oct 19 09:02:33.759811 kernel: Loading compiled-in X.509 certificates Oct 19 09:02:33.759830 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.18.45-flatcar: eb2f6e3256f097862db6e33860ef3802ed8c5e34' Oct 19 09:02:33.759848 kernel: Demotion targets for Node 0: null Oct 19 09:02:33.759867 kernel: Key type .fscrypt registered Oct 19 09:02:33.759885 kernel: Key type fscrypt-provisioning registered Oct 19 09:02:33.759911 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 19 09:02:33.759930 kernel: ima: Allocated hash algorithm: sha1 Oct 19 09:02:33.759948 kernel: ima: No architecture policies found Oct 19 09:02:33.760406 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 19 09:02:33.762252 kernel: clk: Disabling unused clocks Oct 19 09:02:33.762698 kernel: PM: genpd: Disabling unused power domains Oct 19 09:02:33.762725 kernel: Freeing unused kernel memory: 13568K Oct 19 09:02:33.762758 kernel: Run /init as init process Oct 19 09:02:33.762777 kernel: with arguments: Oct 19 09:02:33.762796 kernel: /init Oct 19 09:02:33.762813 kernel: with environment: Oct 19 09:02:33.762831 kernel: HOME=/ Oct 19 09:02:33.762850 kernel: TERM=linux Oct 19 09:02:33.762870 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Oct 19 09:02:33.764397 kernel: nvme nvme0: pci function 0000:00:04.0 Oct 19 09:02:33.764718 kernel: nvme nvme0: 2/0/0 default/read/poll queues Oct 19 09:02:33.764749 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 19 09:02:33.764769 kernel: GPT:25804799 != 33554431 Oct 19 09:02:33.764788 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 19 09:02:33.764806 kernel: GPT:25804799 != 33554431 Oct 19 09:02:33.764825 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 19 09:02:33.764852 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 19 09:02:33.764872 kernel: SCSI subsystem initialized Oct 19 09:02:33.764894 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 19 09:02:33.764913 kernel: device-mapper: uevent: version 1.0.3 Oct 19 09:02:33.764932 kernel: device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev Oct 19 09:02:33.764950 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:33.765102 kernel: raid6: neonx8 gen() 6600 MB/s Oct 19 09:02:33.765395 kernel: raid6: neonx4 gen() 6499 MB/s Oct 19 09:02:33.765417 kernel: raid6: neonx2 gen() 5509 MB/s Oct 19 09:02:33.765436 kernel: raid6: neonx1 gen() 4000 MB/s Oct 19 09:02:33.765455 kernel: raid6: int64x8 gen() 3169 MB/s Oct 19 09:02:33.765474 kernel: raid6: int64x4 gen() 3710 MB/s Oct 19 09:02:33.765493 kernel: raid6: int64x2 gen() 3676 MB/s Oct 19 09:02:33.765512 kernel: raid6: int64x1 gen() 2770 MB/s Oct 19 09:02:33.765542 kernel: raid6: using algorithm neonx8 gen() 6600 MB/s Oct 19 09:02:33.765561 kernel: raid6: .... xor() 4566 MB/s, rmw enabled Oct 19 09:02:33.765580 kernel: raid6: using neon recovery algorithm Oct 19 09:02:33.765598 kernel: xor: measuring software checksum speed Oct 19 09:02:33.765616 kernel: 8regs : 10582 MB/sec Oct 19 09:02:33.765636 kernel: 32regs : 11016 MB/sec Oct 19 09:02:33.765654 kernel: arm64_neon : 8453 MB/sec Oct 19 09:02:33.765677 kernel: xor: using function: 32regs (11016 MB/sec) Oct 19 09:02:33.765697 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 19 09:02:33.765716 kernel: BTRFS: device fsid aad13a72-0a5f-4e5d-9f7a-9d5487a9524d devid 1 transid 40 /dev/mapper/usr (254:0) scanned by mount (208) Oct 19 09:02:33.765736 kernel: BTRFS info (device dm-0): first mount of filesystem aad13a72-0a5f-4e5d-9f7a-9d5487a9524d Oct 19 09:02:33.765754 kernel: BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm Oct 19 09:02:33.765772 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Oct 19 09:02:33.765790 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Oct 19 09:02:33.765814 kernel: BTRFS info (device dm-0 state E): enabling free space tree Oct 19 09:02:33.765832 kernel: loop: module loaded Oct 19 09:02:33.765850 kernel: loop0: detected capacity change from 0 to 102088 Oct 19 09:02:33.765869 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 19 09:02:33.765892 systemd[1]: Successfully made /usr/ read-only. Oct 19 09:02:33.765919 systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Oct 19 09:02:33.765946 systemd[1]: Detected virtualization amazon. Oct 19 09:02:33.766009 systemd[1]: Detected architecture arm64. Oct 19 09:02:33.766034 systemd[1]: Running in initrd. Oct 19 09:02:33.766056 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 19 09:02:33.766077 systemd[1]: No hostname configured, using default hostname. Oct 19 09:02:33.766098 systemd[1]: Hostname set to . Oct 19 09:02:33.766119 systemd[1]: Queued start job for default target initrd.target. Oct 19 09:02:33.766153 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 19 09:02:33.766192 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 19 09:02:33.766221 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 19 09:02:33.766243 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 19 09:02:33.766270 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 19 09:02:33.766293 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 19 09:02:33.766314 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 19 09:02:33.766335 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 19 09:02:33.766356 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 19 09:02:33.766376 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 19 09:02:33.766402 systemd[1]: Reached target paths.target - Path Units. Oct 19 09:02:33.766423 systemd[1]: Reached target slices.target - Slice Units. Oct 19 09:02:33.766444 systemd[1]: Reached target swap.target - Swaps. Oct 19 09:02:33.766465 systemd[1]: Reached target timers.target - Timer Units. Oct 19 09:02:33.766487 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 19 09:02:33.766508 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 19 09:02:33.766529 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 19 09:02:33.766556 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 19 09:02:33.766578 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 19 09:02:33.766600 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 19 09:02:33.766622 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 19 09:02:33.766643 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 19 09:02:33.766665 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 19 09:02:33.766688 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 19 09:02:33.766716 systemd[1]: Reached target sockets.target - Socket Units. Oct 19 09:02:33.766739 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 19 09:02:33.766760 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 19 09:02:33.766781 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 19 09:02:33.766803 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 19 09:02:33.766833 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Oct 19 09:02:33.766856 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 19 09:02:33.766878 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 19 09:02:33.766906 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 19 09:02:33.766929 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 09:02:33.766952 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 19 09:02:33.767051 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 19 09:02:33.767081 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 19 09:02:33.767103 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 19 09:02:33.767164 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 19 09:02:33.767187 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 19 09:02:33.767208 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 19 09:02:33.767228 kernel: Bridge firewalling registered Oct 19 09:02:33.767250 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 19 09:02:33.767347 systemd-journald[335]: Collecting audit messages is enabled. Oct 19 09:02:33.767402 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 19 09:02:33.767425 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 19 09:02:33.767447 kernel: audit: type=1130 audit(1792400553.738:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:33.767473 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 19 09:02:33.767497 systemd-journald[335]: Journal started Oct 19 09:02:33.767536 systemd-journald[335]: Runtime Journal (/run/log/journal/ec2f4b728800796b83ed417ad4977199) is 8M, max 75.2M, 67.2M free. Oct 19 09:02:33.738000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:33.589898 systemd-modules-load[338]: Using 2 probe threads Oct 19 09:02:33.700348 systemd-modules-load[338]: Inserted module 'br_netfilter' Oct 19 09:02:33.754260 systemd-vconsole-setup[341]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 19 09:02:33.780433 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 09:02:33.782000 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' Oct 19 09:02:33.793871 kernel: audit: type=1130 audit(1792400553.782: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' Oct 19 09:02:33.794559 systemd[1]: Started systemd-journald.service - Journal Service. Oct 19 09:02:33.793000 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' Oct 19 09:02:33.801111 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 19 09:02:33.801756 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 19 09:02:33.805000 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' Oct 19 09:02:33.806000 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' Oct 19 09:02:33.820187 kernel: audit: type=1130 audit(1792400553.793: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' Oct 19 09:02:33.820223 kernel: audit: type=1130 audit(1792400553.805:5): 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' Oct 19 09:02:33.820254 kernel: audit: type=1131 audit(1792400553.806:6): 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' Oct 19 09:02:33.820553 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 19 09:02:33.825000 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' Oct 19 09:02:33.832089 kernel: audit: type=1130 audit(1792400553.825:7): 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' Oct 19 09:02:33.835644 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 19 09:02:33.841000 audit: BPF prog-id=5 op=LOAD Oct 19 09:02:33.845032 kernel: audit: type=1334 audit(1792400553.841:8): prog-id=5 op=LOAD Oct 19 09:02:33.848650 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 19 09:02:33.861220 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 19 09:02:33.895728 systemd-tmpfiles[358]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Oct 19 09:02:33.895892 systemd-tmpfiles[358]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 19 09:02:33.917242 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 19 09:02:33.915000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:33.935995 kernel: audit: type=1130 audit(1792400553.915:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:33.937530 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 19 09:02:33.952000 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' Oct 19 09:02:33.960006 kernel: audit: type=1130 audit(1792400553.952:10): 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' Oct 19 09:02:33.963179 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 19 09:02:33.989428 systemd-resolved[357]: Positive Trust Anchors: Oct 19 09:02:33.990016 systemd-resolved[357]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 19 09:02:33.990027 systemd-resolved[357]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 19 09:02:33.990091 systemd-resolved[357]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 19 09:02:34.049056 dracut-cmdline[370]: dracut-112 Oct 19 09:02:34.062518 dracut-cmdline[370]: Using kernel command line parameters: SYSTEMD_SULOGIN_FORCE=1 BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=f1f52c5d7d8fc22fc51e600c3f4777f00e7bd5639af44f451541d366f3a93d64 Oct 19 09:02:34.312035 kernel: Loading iSCSI transport class v2.0-870. Oct 19 09:02:34.316101 kernel: random: crng init done Oct 19 09:02:34.360792 systemd-resolved[357]: Defaulting to hostname 'linux'. Oct 19 09:02:34.367938 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 19 09:02:34.370000 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' Oct 19 09:02:34.386334 kernel: iscsi: registered transport (tcp) Oct 19 09:02:34.372134 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 19 09:02:34.389149 kernel: audit: type=1130 audit(1792400554.370:11): 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' Oct 19 09:02:34.411520 kernel: iscsi: registered transport (qla4xxx) Oct 19 09:02:34.411612 kernel: QLogic iSCSI HBA Driver Oct 19 09:02:34.481801 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 19 09:02:34.514814 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 19 09:02:34.518000 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' Oct 19 09:02:34.523241 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 19 09:02:34.581209 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 19 09:02:34.585000 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' Oct 19 09:02:34.586000 audit: BPF prog-id=6 op=LOAD Oct 19 09:02:34.587000 audit: BPF prog-id=7 op=LOAD Oct 19 09:02:34.589501 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 19 09:02:34.661834 systemd-udevd[505]: Using default interface naming scheme 'v261'. Oct 19 09:02:34.703427 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 19 09:02:34.708000 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' Oct 19 09:02:34.715798 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 19 09:02:34.724000 audit: BPF prog-id=8 op=LOAD Oct 19 09:02:34.727530 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 19 09:02:34.781067 dracut-pre-trigger[507]: rd.md=0: removing MD RAID activation Oct 19 09:02:34.840039 systemd-networkd[517]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Oct 19 09:02:34.849191 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 19 09:02:34.853000 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' Oct 19 09:02:34.858182 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 19 09:02:34.873951 systemd-networkd[517]: lo: Link UP Oct 19 09:02:34.874499 systemd-networkd[517]: lo: Gained carrier Oct 19 09:02:34.878472 systemd[1]: Started systemd-networkd.service - Network Management. Oct 19 09:02:34.881000 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' Oct 19 09:02:34.883599 systemd[1]: Reached target network.target - Network. Oct 19 09:02:35.103240 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 19 09:02:35.105000 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' Oct 19 09:02:35.111741 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 19 09:02:35.397120 kernel: nvme nvme0: using unchecked data buffer Oct 19 09:02:35.511364 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 19 09:02:35.511433 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 19 09:02:35.513532 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 19 09:02:35.516475 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 09:02:35.522000 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' Oct 19 09:02:35.523586 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 09:02:35.534036 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 09:02:35.565047 kernel: PTP clock support registered Oct 19 09:02:35.590361 systemd-vconsole-setup[611]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 19 09:02:35.600766 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 09:02:35.602000 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' Oct 19 09:02:35.673081 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 19 09:02:35.673165 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Oct 19 09:02:35.688536 kernel: ena 0000:00:05.0: ENA device version: 0.10 Oct 19 09:02:35.690166 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Oct 19 09:02:35.704006 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80110000, mac addr 06:ff:d4:15:de:31 Oct 19 09:02:35.708723 (udev-worker)[570]: Network interface NamePolicy= disabled on kernel command line. Oct 19 09:02:35.721435 systemd-networkd[517]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 19 09:02:35.735575 systemd-networkd[517]: eth0: Link UP Oct 19 09:02:35.735890 systemd-networkd[517]: eth0: Gained carrier Oct 19 09:02:35.750862 systemd-networkd[517]: eth0: DHCPv4 address 172.31.24.189/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 19 09:02:35.804891 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Oct 19 09:02:35.841015 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Oct 19 09:02:35.842000 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' Oct 19 09:02:35.844101 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 19 09:02:35.878236 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Oct 19 09:02:35.908103 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Oct 19 09:02:35.908543 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 19 09:02:35.909429 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 19 09:02:35.910137 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 19 09:02:35.915665 systemd[1]: Mounting oem.mount - /oem... Oct 19 09:02:35.922706 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 19 09:02:35.953332 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (694) Oct 19 09:02:35.961007 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 347822a4-45d3-433b-b4f0-5fa21a5017c3 Oct 19 09:02:35.961081 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-lib) checksum algorithm Oct 19 09:02:35.971329 disk-uuid[710]: Primary Header is updated. Oct 19 09:02:35.971329 disk-uuid[710]: Secondary Entries is updated. Oct 19 09:02:35.971329 disk-uuid[710]: Secondary Header is updated. Oct 19 09:02:35.991419 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 19 09:02:35.991491 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 19 09:02:35.995461 systemd[1]: Mounted oem.mount - /oem. Oct 19 09:02:36.001394 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 19 09:02:36.976160 ignition[716]: Ignition 2.27.0 Oct 19 09:02:36.976190 ignition[716]: Stage: fetch-offline Oct 19 09:02:36.978077 ignition[716]: no config dir at "/run/ignition/base.d" Oct 19 09:02:36.978112 ignition[716]: no config dir at "/etc/ignition/base.d" Oct 19 09:02:36.978188 ignition[716]: no config dir at "/usr/lib/ignition/base.d" Oct 19 09:02:36.978199 ignition[716]: no configs found in "base.d" across system config directories Oct 19 09:02:36.979603 ignition[716]: no config dir at "/run/ignition/base.platform.d/aws" Oct 19 09:02:36.979620 ignition[716]: no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 09:02:36.979646 ignition[716]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 09:02:36.979655 ignition[716]: no configs found in "base.platform.d/aws" across system config directories Oct 19 09:02:36.995441 ignition[716]: Ignition finished successfully Oct 19 09:02:37.001778 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 19 09:02:37.000000 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' Oct 19 09:02:37.006026 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 19 09:02:37.040696 ignition[893]: Ignition 2.27.0 Oct 19 09:02:37.040731 ignition[893]: Stage: fetch Oct 19 09:02:37.044439 ignition[893]: no config dir at "/run/ignition/base.d" Oct 19 09:02:37.044474 ignition[893]: no config dir at "/etc/ignition/base.d" Oct 19 09:02:37.044506 ignition[893]: no config dir at "/usr/lib/ignition/base.d" Oct 19 09:02:37.044516 ignition[893]: no configs found in "base.d" across system config directories Oct 19 09:02:37.044538 ignition[893]: no config dir at "/run/ignition/base.platform.d/aws" Oct 19 09:02:37.044554 ignition[893]: no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 09:02:37.044608 ignition[893]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 09:02:37.044658 ignition[893]: no configs found in "base.platform.d/aws" across system config directories Oct 19 09:02:37.046509 ignition[893]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 09:02:37.069943 ignition[893]: PUT result: OK Oct 19 09:02:37.074896 ignition[893]: reading system config file "/run/ignition/user.ign" Oct 19 09:02:37.074991 ignition[893]: no config at "/run/ignition/user.ign" Oct 19 09:02:37.075008 ignition[893]: reading system config file "/etc/ignition/user.ign" Oct 19 09:02:37.088194 disk-uuid[712]: Warning: The kernel is still using the old partition table. Oct 19 09:02:37.088194 disk-uuid[712]: The new table will be used at the next reboot or after you Oct 19 09:02:37.088194 disk-uuid[712]: run partprobe(8) or kpartx(8) Oct 19 09:02:37.088194 disk-uuid[712]: The operation has completed successfully. Oct 19 09:02:37.099000 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' Oct 19 09:02:37.100000 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' Oct 19 09:02:37.075026 ignition[893]: no config at "/etc/ignition/user.ign" Oct 19 09:02:37.095745 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 19 09:02:37.075037 ignition[893]: reading system config file "/usr/lib/ignition/user.ign" Oct 19 09:02:37.096234 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 19 09:02:37.075182 ignition[893]: no config at "/usr/lib/ignition/user.ign" Oct 19 09:02:37.111289 systemd[1]: Mounting boot.mount - Boot partition... Oct 19 09:02:37.075271 ignition[893]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 09:02:37.080235 ignition[893]: PUT result: OK Oct 19 09:02:37.080416 ignition[893]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Oct 19 09:02:37.081898 ignition[893]: GET result: OK Oct 19 09:02:37.082159 ignition[893]: parsing config with SHA512: 31689a7c8feb59a2976314787b59c158a9bab11ecdc55f6db09548cd1c477f2213ab2c698611b4a85187510fc3f581b8ce1798dec59a12087393a97c7ee8ab91 Oct 19 09:02:37.133243 unknown[893]: fetched base config from "system" Oct 19 09:02:37.133553 ignition[893]: fetch: fetch complete Oct 19 09:02:37.133266 unknown[893]: fetched base config from "system" Oct 19 09:02:37.133564 ignition[893]: fetch: fetch passed Oct 19 09:02:37.133280 unknown[893]: fetched user config from "aws" Oct 19 09:02:37.133649 ignition[893]: Ignition finished successfully Oct 19 09:02:37.146122 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 19 09:02:37.155000 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' Oct 19 09:02:37.160801 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 19 09:02:37.199761 ignition[904]: Ignition 2.27.0 Oct 19 09:02:37.199788 ignition[904]: Stage: kargs Oct 19 09:02:37.200253 ignition[904]: no config dir at "/run/ignition/base.d" Oct 19 09:02:37.200273 ignition[904]: no config dir at "/etc/ignition/base.d" Oct 19 09:02:37.200305 ignition[904]: no config dir at "/usr/lib/ignition/base.d" Oct 19 09:02:37.200315 ignition[904]: no configs found in "base.d" across system config directories Oct 19 09:02:37.200338 ignition[904]: no config dir at "/run/ignition/base.platform.d/aws" Oct 19 09:02:37.200354 ignition[904]: no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 09:02:37.215707 systemd-networkd[517]: eth0: Gained IPv6LL Oct 19 09:02:37.200371 ignition[904]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 09:02:37.200381 ignition[904]: no configs found in "base.platform.d/aws" across system config directories Oct 19 09:02:37.200583 ignition[904]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 09:02:37.208805 ignition[904]: PUT result: OK Oct 19 09:02:37.236753 ignition[904]: kargs: kargs passed Oct 19 09:02:37.238648 ignition[904]: Ignition finished successfully Oct 19 09:02:37.243273 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 19 09:02:37.251000 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' Oct 19 09:02:37.255023 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 19 09:02:37.270756 systemd[1]: Mounted boot.mount - Boot partition. Oct 19 09:02:37.306434 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 19 09:02:37.308481 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 19 09:02:37.310000 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' Oct 19 09:02:37.313000 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' Oct 19 09:02:37.311584 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 19 09:02:37.318000 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' Oct 19 09:02:37.311819 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 19 09:02:37.314844 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 19 09:02:37.315117 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 19 09:02:37.320676 systemd[1]: Unmounting oem.mount - /oem... Oct 19 09:02:37.354004 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 347822a4-45d3-433b-b4f0-5fa21a5017c3 Oct 19 09:02:37.355944 systemd[1]: oem.mount: Deactivated successfully. Oct 19 09:02:37.358041 systemd[1]: Unmounted oem.mount - /oem. Oct 19 09:02:37.401597 ignition[918]: Ignition 2.27.0 Oct 19 09:02:37.401631 ignition[918]: Stage: disks Oct 19 09:02:37.402157 ignition[918]: no config dir at "/run/ignition/base.d" Oct 19 09:02:37.402176 ignition[918]: no config dir at "/etc/ignition/base.d" Oct 19 09:02:37.402215 ignition[918]: no config dir at "/usr/lib/ignition/base.d" Oct 19 09:02:37.402225 ignition[918]: no configs found in "base.d" across system config directories Oct 19 09:02:37.402248 ignition[918]: no config dir at "/run/ignition/base.platform.d/aws" Oct 19 09:02:37.402309 ignition[918]: no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 09:02:37.402332 ignition[918]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 09:02:37.402342 ignition[918]: no configs found in "base.platform.d/aws" across system config directories Oct 19 09:02:37.402538 ignition[918]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 09:02:37.408164 ignition[918]: PUT result: OK Oct 19 09:02:37.434192 ignition[918]: disks: disks passed Oct 19 09:02:37.434834 ignition[918]: Ignition finished successfully Oct 19 09:02:37.438491 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 19 09:02:37.442000 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' Oct 19 09:02:37.444444 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 19 09:02:37.447403 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 19 09:02:37.452899 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 19 09:02:37.460089 systemd[1]: Reached target sysinit.target - System Initialization. Oct 19 09:02:37.467761 systemd[1]: Reached target basic.target - Basic System. Oct 19 09:02:37.479615 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 19 09:02:37.520208 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 19 09:02:37.521000 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' Oct 19 09:02:37.527701 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 19 09:02:37.595314 systemd-fsck[938]: ROOT: clean, 15/1631200 files, 112378/1617920 blocks Oct 19 09:02:37.600141 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 19 09:02:37.604000 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' Oct 19 09:02:37.609894 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 19 09:02:37.782991 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 8fbb9091-4a24-491f-a22c-6e1b22d896c8 r/w with ordered data mode. Quota mode: none. Oct 19 09:02:37.784690 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 19 09:02:37.791906 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 19 09:02:37.799477 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 19 09:02:37.811845 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent skipped, no trigger condition checks were met. Oct 19 09:02:37.811934 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Oct 19 09:02:37.812015 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 19 09:02:37.840383 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 19 09:02:37.842336 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 19 09:02:39.187990 kernel: loop1: detected capacity change from 0 to 44497 Oct 19 09:02:39.257332 kernel: loop1: p1 p2 p3 Oct 19 09:02:39.381212 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:39.381284 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:39.381311 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:39.382941 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:39.384230 systemd-confext[1031]: device-mapper: reload ioctl on loop1p1-12-verity (254:1) failed: Invalid argument Oct 19 09:02:39.396998 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:39.660987 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Oct 19 09:02:39.717005 kernel: loop2: detected capacity change from 0 to 44497 Oct 19 09:02:39.725308 kernel: loop2: p1 p2 p3 Oct 19 09:02:39.734989 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:39.735051 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:39.735108 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:39.737014 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:39.737549 (sd-merge)[1042]: device-mapper: reload ioctl on loop2p1-16-verity (254:1) failed: Invalid argument Oct 19 09:02:39.747423 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:39.786012 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Oct 19 09:02:39.786587 (sd-merge)[1042]: Using extensions '00-flatcar-default.raw'. Oct 19 09:02:39.788765 (sd-merge)[1042]: Merged extensions into '/sysroot/etc'. Oct 19 09:02:39.800450 initrd-setup-root[1049]: /etc 00-flatcar-default Mon 2026-10-19 09:02:33 UTC Oct 19 09:02:39.805349 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 19 09:02:39.806000 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' Oct 19 09:02:39.818765 kernel: kauditd_printk_skb: 23 callbacks suppressed Oct 19 09:02:39.811044 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 19 09:02:39.821134 kernel: audit: type=1130 audit(1792400559.806:35): 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' Oct 19 09:02:39.877520 ignition[1053]: INFO : Ignition 2.27.0 Oct 19 09:02:39.877520 ignition[1053]: INFO : Stage: mount Oct 19 09:02:39.881823 ignition[1053]: INFO : no config dir at "/run/ignition/base.d" Oct 19 09:02:39.881823 ignition[1053]: INFO : no config dir at "/etc/ignition/base.d" Oct 19 09:02:39.881823 ignition[1053]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 19 09:02:39.881823 ignition[1053]: INFO : no configs found in "base.d" across system config directories Oct 19 09:02:39.881823 ignition[1053]: INFO : no config dir at "/run/ignition/base.platform.d/aws" Oct 19 09:02:39.881823 ignition[1053]: INFO : no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 09:02:39.881823 ignition[1053]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 09:02:39.881823 ignition[1053]: INFO : no configs found in "base.platform.d/aws" across system config directories Oct 19 09:02:39.881823 ignition[1053]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 09:02:39.899000 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' Oct 19 09:02:39.921695 kernel: audit: type=1130 audit(1792400559.899:36): 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' Oct 19 09:02:39.921743 ignition[1053]: INFO : PUT result: OK Oct 19 09:02:39.921743 ignition[1053]: INFO : mount: mount passed Oct 19 09:02:39.921743 ignition[1053]: INFO : Ignition finished successfully Oct 19 09:02:39.900439 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 19 09:02:39.902228 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 19 09:02:39.944612 systemd[1]: Mounting oem.mount - /oem... Oct 19 09:02:39.970018 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1062) Oct 19 09:02:39.975625 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 347822a4-45d3-433b-b4f0-5fa21a5017c3 Oct 19 09:02:39.975708 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-lib) checksum algorithm Oct 19 09:02:39.986694 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 19 09:02:39.986772 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 19 09:02:39.991223 systemd[1]: Mounted oem.mount - /oem. Oct 19 09:02:39.997306 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 19 09:02:40.025080 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 19 09:02:40.064569 ignition[1081]: INFO : Ignition 2.27.0 Oct 19 09:02:40.066743 ignition[1081]: INFO : Stage: files Oct 19 09:02:40.066743 ignition[1081]: INFO : no config dir at "/run/ignition/base.d" Oct 19 09:02:40.071196 ignition[1081]: INFO : no config dir at "/etc/ignition/base.d" Oct 19 09:02:40.071196 ignition[1081]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 19 09:02:40.071196 ignition[1081]: INFO : no configs found in "base.d" across system config directories Oct 19 09:02:40.071196 ignition[1081]: INFO : no config dir at "/run/ignition/base.platform.d/aws" Oct 19 09:02:40.071196 ignition[1081]: INFO : no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 09:02:40.071196 ignition[1081]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 09:02:40.071196 ignition[1081]: INFO : no configs found in "base.platform.d/aws" across system config directories Oct 19 09:02:40.071196 ignition[1081]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 09:02:40.094861 ignition[1081]: INFO : PUT result: OK Oct 19 09:02:40.094861 ignition[1081]: DEBUG : files: compiled without relabeling support, skipping Oct 19 09:02:40.100009 ignition[1081]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 19 09:02:40.100009 ignition[1081]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 19 09:02:40.110992 ignition[1081]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 19 09:02:40.114633 ignition[1081]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 19 09:02:40.120003 unknown[1081]: wrote ssh authorized keys file for user: core Oct 19 09:02:40.123198 ignition[1081]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 19 09:02:40.126773 ignition[1081]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 19 09:02:40.131305 ignition[1081]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 19 09:02:40.135648 ignition[1081]: INFO : files: op(4): [started] processing unit "etcd-member.service" Oct 19 09:02:40.171016 ignition[1081]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Oct 19 09:02:40.171016 ignition[1081]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Oct 19 09:02:40.171016 ignition[1081]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Oct 19 09:02:40.171016 ignition[1081]: INFO : files: op(6): [started] setting preset to enabled for "etcd-member.service" Oct 19 09:02:40.190005 ignition[1081]: INFO : files: op(6): [finished] setting preset to enabled for "etcd-member.service" Oct 19 09:02:40.190005 ignition[1081]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 19 09:02:40.190005 ignition[1081]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 19 09:02:40.190005 ignition[1081]: INFO : files: files passed Oct 19 09:02:40.190005 ignition[1081]: INFO : Ignition finished successfully Oct 19 09:02:40.194000 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' Oct 19 09:02:40.189818 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 19 09:02:40.198144 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 19 09:02:40.207006 kernel: audit: type=1130 audit(1792400560.194:37): 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' Oct 19 09:02:40.223175 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 19 09:02:40.240568 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 19 09:02:40.246000 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' Oct 19 09:02:40.250000 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' Oct 19 09:02:40.240879 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 19 09:02:40.261599 kernel: audit: type=1130 audit(1792400560.246:38): 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' Oct 19 09:02:40.261642 kernel: audit: type=1131 audit(1792400560.250:39): 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' Oct 19 09:02:40.308447 initrd-setup-root-after-ignition[1114]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 19 09:02:40.308447 initrd-setup-root-after-ignition[1114]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 19 09:02:40.317595 initrd-setup-root-after-ignition[1118]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 19 09:02:40.330008 kernel: loop3: detected capacity change from 0 to 44497 Oct 19 09:02:40.338014 kernel: loop3: p1 p2 p3 Oct 19 09:02:40.356374 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:40.356439 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:40.358623 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:40.360187 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:40.360300 systemd-confext[1120]: device-mapper: reload ioctl on loop3p1-19-verity (254:2) failed: Invalid argument Oct 19 09:02:40.384020 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:40.422002 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Oct 19 09:02:40.457033 kernel: loop4: detected capacity change from 0 to 44497 Oct 19 09:02:40.468993 kernel: loop4: p1 p2 p3 Oct 19 09:02:40.474112 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:40.474179 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:40.474206 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:40.477231 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:40.479074 (sd-merge)[1128]: device-mapper: reload ioctl on loop4p1-23-verity (254:2) failed: Invalid argument Oct 19 09:02:40.489019 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:40.533021 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Oct 19 09:02:40.534055 (sd-merge)[1128]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 19 09:02:40.592028 kernel: loop4: detected capacity change from 0 to 404352 Oct 19 09:02:40.642009 kernel: loop4: p1 p2 p3 Oct 19 09:02:40.729922 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:40.730033 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:40.730064 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:40.731846 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:40.733218 systemd-sysext[1136]: device-mapper: reload ioctl on loop4p1-27-verity (254:2) failed: Invalid argument Oct 19 09:02:40.747088 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:40.996100 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 09:02:41.096997 kernel: loop5: detected capacity change from 0 to 305992 Oct 19 09:02:41.111061 kernel: loop5: p1 p2 p3 Oct 19 09:02:41.123003 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:41.123102 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:41.123133 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:41.126006 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:41.126054 systemd-sysext[1136]: device-mapper: reload ioctl on loop5p1-31-verity (254:2) failed: Invalid argument Oct 19 09:02:41.139264 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:41.208998 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 09:02:41.281044 kernel: loop6: detected capacity change from 0 to 158624 Oct 19 09:02:41.324195 kernel: loop6: p1 p2 p3 Oct 19 09:02:41.359442 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:41.359525 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:41.359557 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:41.362512 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:41.362656 systemd-sysext[1136]: device-mapper: reload ioctl on loop6p1-35-verity (254:2) failed: Invalid argument Oct 19 09:02:41.370997 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:41.558029 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 09:02:41.590004 kernel: loop7: detected capacity change from 0 to 404352 Oct 19 09:02:41.600032 kernel: loop7: p1 p2 p3 Oct 19 09:02:41.609270 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:41.609352 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:41.611360 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:41.612831 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:41.612938 (sd-merge)[1159]: device-mapper: reload ioctl on loop7p1-39-verity (254:2) failed: Invalid argument Oct 19 09:02:41.626011 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:41.683014 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 09:02:41.689004 kernel: loop1: detected capacity change from 0 to 305992 Oct 19 09:02:41.699605 kernel: loop1: p1 p2 p3 Oct 19 09:02:41.707699 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:41.707767 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:41.709724 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:41.711106 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:41.711204 (sd-merge)[1159]: device-mapper: reload ioctl on loop1p1-43-verity (254:3) failed: Invalid argument Oct 19 09:02:41.718021 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:41.776883 kernel: erofs (device dm-3): mounted with root inode @ nid 39. Oct 19 09:02:41.780009 kernel: loop3: detected capacity change from 0 to 158624 Oct 19 09:02:41.791056 kernel: loop3: p1 p2 p3 Oct 19 09:02:41.799791 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:41.799860 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:41.799898 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:41.803086 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:41.803172 (sd-merge)[1159]: device-mapper: reload ioctl on loop3p1-47-verity (254:4) failed: Invalid argument Oct 19 09:02:41.811030 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:41.876006 kernel: erofs (device dm-4): mounted with root inode @ nid 39. Oct 19 09:02:41.875707 (sd-merge)[1159]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-ami-9999.9.9+enable-nvidia-580-1.raw'. Oct 19 09:02:41.877946 (sd-merge)[1159]: Merged extensions into '/sysroot/usr'. Oct 19 09:02:41.889168 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 19 09:02:41.891000 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' Oct 19 09:02:41.894944 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 19 09:02:41.909171 kernel: audit: type=1130 audit(1792400561.891:40): 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' Oct 19 09:02:41.946565 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 19 09:02:41.949175 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 19 09:02:41.955192 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Oct 19 09:02:41.955656 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 19 09:02:41.954000 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' Oct 19 09:02:41.960572 systemd[1]: dracut-mount.service - dracut mount hook skipped, no trigger condition checks were met. Oct 19 09:02:41.954000 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' Oct 19 09:02:41.979449 kernel: audit: type=1130 audit(1792400561.954:41): 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' Oct 19 09:02:41.962886 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 19 09:02:41.982237 kernel: audit: type=1131 audit(1792400561.954:42): 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' Oct 19 09:02:42.015347 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 19 09:02:42.019000 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' Oct 19 09:02:42.025366 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 19 09:02:42.031315 kernel: audit: type=1130 audit(1792400562.019:43): 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' Oct 19 09:02:42.060354 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 19 09:02:42.063558 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 19 09:02:42.071397 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 19 09:02:42.076807 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 19 09:02:42.082478 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 19 09:02:42.085896 systemd[1]: Stopped target timers.target - Timer Units. Oct 19 09:02:42.090784 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 19 09:02:42.091035 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Oct 19 09:02:42.100000 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' Oct 19 09:02:42.107719 kernel: audit: type=1131 audit(1792400562.100:44): 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' Oct 19 09:02:42.095954 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 19 09:02:42.096257 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 19 09:02:42.101705 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 19 09:02:42.110284 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 19 09:02:42.118834 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 19 09:02:42.125000 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' Oct 19 09:02:42.119278 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 19 09:02:42.126833 systemd[1]: Stopped target basic.target - Basic System. Oct 19 09:02:42.131485 systemd[1]: Stopped target paths.target - Path Units. Oct 19 09:02:42.135311 systemd[1]: Stopped target slices.target - Slice Units. Oct 19 09:02:42.143494 systemd[1]: Stopped target sockets.target - Socket Units. Oct 19 09:02:42.147767 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 19 09:02:42.154034 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 19 09:02:42.158826 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 19 09:02:42.159624 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 19 09:02:42.161070 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 19 09:02:42.161734 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 19 09:02:42.162349 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 19 09:02:42.168864 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 19 09:02:42.177707 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Oct 19 09:02:42.182059 systemd[1]: Stopped target swap.target - Swaps. Oct 19 09:02:42.188701 systemd[1]: iscsid.socket: Deactivated successfully. Oct 19 09:02:42.203000 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' Oct 19 09:02:42.188925 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 19 09:02:42.193430 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 19 09:02:42.211000 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' Oct 19 09:02:42.214000 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' Oct 19 09:02:42.193608 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 19 09:02:42.197204 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Oct 19 09:02:42.197368 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Oct 19 09:02:42.229000 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' Oct 19 09:02:42.233000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:42.200101 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 19 09:02:42.200312 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 19 09:02:42.243000 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' Oct 19 09:02:42.204421 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 19 09:02:42.204672 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 19 09:02:42.212472 systemd[1]: ignition-files.service: Deactivated successfully. Oct 19 09:02:42.270000 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' Oct 19 09:02:42.212748 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 19 09:02:42.281457 ignition[1196]: INFO : Ignition 2.27.0 Oct 19 09:02:42.281457 ignition[1196]: INFO : Stage: umount Oct 19 09:02:42.281457 ignition[1196]: INFO : no config dir at "/run/ignition/base.d" Oct 19 09:02:42.281457 ignition[1196]: INFO : no config dir at "/etc/ignition/base.d" Oct 19 09:02:42.281457 ignition[1196]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 19 09:02:42.281457 ignition[1196]: INFO : no configs found in "base.d" across system config directories Oct 19 09:02:42.281457 ignition[1196]: INFO : no config dir at "/run/ignition/base.platform.d/aws" Oct 19 09:02:42.281457 ignition[1196]: INFO : no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 09:02:42.281457 ignition[1196]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 09:02:42.281457 ignition[1196]: INFO : no configs found in "base.platform.d/aws" across system config directories Oct 19 09:02:42.281457 ignition[1196]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 09:02:42.281457 ignition[1196]: INFO : PUT result: OK Oct 19 09:02:42.281457 ignition[1196]: INFO : umount: umount passed Oct 19 09:02:42.281457 ignition[1196]: INFO : Ignition finished successfully Oct 19 09:02:42.287000 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' Oct 19 09:02:42.217480 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 19 09:02:42.223932 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 19 09:02:42.226183 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 19 09:02:42.230572 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 19 09:02:42.230851 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 19 09:02:42.234828 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 19 09:02:42.237242 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 19 09:02:42.244612 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 19 09:02:42.244869 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 19 09:02:42.284751 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 19 09:02:42.285722 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 19 09:02:42.289123 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 19 09:02:42.289446 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 19 09:02:42.344000 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' Oct 19 09:02:42.345000 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' Oct 19 09:02:42.349795 systemd[1]: Stopped target network.target - Network. Oct 19 09:02:42.354140 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 19 09:02:42.354284 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 19 09:02:42.357000 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' Oct 19 09:02:42.360978 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 19 09:02:42.361096 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 19 09:02:42.364000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:42.367905 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 19 09:02:42.368058 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 19 09:02:42.373000 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' Oct 19 09:02:42.374863 systemd-networkd[517]: eth0: DHCP lease lost Oct 19 09:02:42.374904 systemd[1]: Stopping systemd-networkd.service - Network Management... Oct 19 09:02:42.377648 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 19 09:02:42.391006 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 19 09:02:42.391423 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 19 09:02:42.397000 audit: BPF prog-id=5 op=UNLOAD Oct 19 09:02:42.397000 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' Oct 19 09:02:42.403254 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 19 09:02:42.406024 systemd[1]: Stopped systemd-networkd.service - Network Management. Oct 19 09:02:42.409000 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' Oct 19 09:02:42.416181 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Oct 19 09:02:42.415000 audit: BPF prog-id=8 op=UNLOAD Oct 19 09:02:42.416379 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 19 09:02:42.416805 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 19 09:02:42.427834 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 19 09:02:42.427954 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Oct 19 09:02:42.433643 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 19 09:02:42.443935 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 19 09:02:42.485579 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 19 09:02:42.487311 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 19 09:02:42.490000 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' Oct 19 09:02:42.491197 systemd[1]: systemd-udevd.service: Consumed 2.647s CPU time over 7.896s wall clock time. Oct 19 09:02:42.493076 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 19 09:02:42.493236 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 19 09:02:42.501426 systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully. Oct 19 09:02:42.505107 systemd[1]: Closed systemd-udevd-varlink.socket - udev Varlink Socket. Oct 19 09:02:42.510271 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 19 09:02:42.525000 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' Oct 19 09:02:42.510368 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 19 09:02:42.528561 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 19 09:02:42.532000 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' Oct 19 09:02:42.528661 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 19 09:02:42.537000 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' Oct 19 09:02:42.533772 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 19 09:02:42.534438 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 19 09:02:42.548835 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 19 09:02:42.555219 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 19 09:02:42.559000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:42.557861 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 19 09:02:42.566000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:42.563182 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 19 09:02:42.572000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:42.578000 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' Oct 19 09:02:42.563285 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 19 09:02:42.570341 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 19 09:02:42.599000 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' Oct 19 09:02:42.570491 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 19 09:02:42.573648 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 19 09:02:42.573739 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 19 09:02:42.584600 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 19 09:02:42.612000 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' Oct 19 09:02:42.584699 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 09:02:42.607319 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 19 09:02:42.621000 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' Oct 19 09:02:42.621000 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' Oct 19 09:02:42.607591 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 19 09:02:42.614920 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 19 09:02:42.615254 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 19 09:02:42.623609 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 19 09:02:42.630437 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 19 09:02:42.665681 systemd[1]: Switching root. Oct 19 09:02:42.747439 systemd-journald[335]: Journal stopped Oct 19 09:02:48.048029 systemd-journald[335]: Received SIGTERM from PID 1 (systemd). Oct 19 09:02:48.048134 kernel: SELinux: policy capability network_peer_controls=1 Oct 19 09:02:48.048182 kernel: SELinux: policy capability open_perms=1 Oct 19 09:02:48.048217 kernel: SELinux: policy capability extended_socket_class=1 Oct 19 09:02:48.048245 kernel: SELinux: policy capability always_check_network=0 Oct 19 09:02:48.048279 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 19 09:02:48.048306 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 19 09:02:48.048332 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 19 09:02:48.048358 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 19 09:02:48.048394 kernel: SELinux: policy capability userspace_initial_context=0 Oct 19 09:02:48.048425 kernel: SELinux: policy capability netlink_xperm=0 Oct 19 09:02:48.048452 kernel: SELinux: policy capability netif_wildcard=0 Oct 19 09:02:48.048479 kernel: SELinux: policy capability genfs_seclabel_wildcard=0 Oct 19 09:02:48.048512 kernel: SELinux: policy capability functionfs_seclabel=0 Oct 19 09:02:48.048541 systemd[1]: Successfully loaded SELinux policy in 245.482ms. Oct 19 09:02:48.048585 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 22.630ms. Oct 19 09:02:48.048616 systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Oct 19 09:02:48.048651 systemd[1]: Detected virtualization amazon. Oct 19 09:02:48.048680 systemd[1]: Detected architecture arm64. Oct 19 09:02:48.048708 systemd[1]: Detected first boot. Oct 19 09:02:48.048737 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 19 09:02:48.048763 kernel: kauditd_printk_skb: 32 callbacks suppressed Oct 19 09:02:48.048790 kernel: audit: type=1334 audit(1792400565.314:77): prog-id=9 op=LOAD Oct 19 09:02:48.048824 kernel: audit: type=1334 audit(1792400565.314:78): prog-id=9 op=UNLOAD Oct 19 09:02:48.048856 zram_generator::config[1237]: No configuration found. Oct 19 09:02:48.048884 kernel: NET: Registered PF_VSOCK protocol family Oct 19 09:02:48.048911 systemd[1]: Applying preset policy. Oct 19 09:02:48.048942 systemd[1]: Created symlink '/etc/systemd/system/multi-user.target.wants/etcd-member.service' → '/usr/lib/systemd/system/etcd-member.service'. Oct 19 09:02:48.048994 systemd[1]: Populated /etc with preset unit settings. Oct 19 09:02:48.049025 kernel: audit: type=1334 audit(1792400567.302:79): prog-id=10 op=LOAD Oct 19 09:02:48.049053 kernel: audit: type=1334 audit(1792400567.302:80): prog-id=2 op=UNLOAD Oct 19 09:02:48.049085 kernel: audit: type=1334 audit(1792400567.303:81): prog-id=11 op=LOAD Oct 19 09:02:48.049112 kernel: audit: type=1334 audit(1792400567.305:82): prog-id=12 op=LOAD Oct 19 09:02:48.049147 kernel: audit: type=1334 audit(1792400567.305:83): prog-id=3 op=UNLOAD Oct 19 09:02:48.049174 kernel: audit: type=1334 audit(1792400567.305:84): prog-id=4 op=UNLOAD Oct 19 09:02:48.049200 kernel: audit: type=1334 audit(1792400567.309:85): prog-id=13 op=LOAD Oct 19 09:02:48.049226 kernel: audit: type=1334 audit(1792400567.309:86): prog-id=10 op=UNLOAD Oct 19 09:02:48.049253 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 19 09:02:48.049286 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 19 09:02:48.049323 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 19 09:02:48.049353 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 19 09:02:48.049383 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 19 09:02:48.049417 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 19 09:02:48.049446 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 19 09:02:48.049479 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 19 09:02:48.049508 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 19 09:02:48.049538 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 19 09:02:48.049566 systemd[1]: Created slice user.slice - User and Session Slice. Oct 19 09:02:48.049594 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 19 09:02:48.049624 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 19 09:02:48.049653 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 19 09:02:48.049686 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 19 09:02:48.049717 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 19 09:02:48.049747 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 19 09:02:48.049776 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 19 09:02:48.049804 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 19 09:02:48.049833 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 19 09:02:48.049861 systemd[1]: Reached target imports.target - Image Downloads. Oct 19 09:02:48.049894 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 19 09:02:48.049923 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 19 09:02:48.049951 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 19 09:02:48.050027 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 19 09:02:48.050058 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 19 09:02:48.050087 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 19 09:02:48.050122 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Oct 19 09:02:48.050158 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Oct 19 09:02:48.050191 systemd[1]: Reached target slices.target - Slice Units. Oct 19 09:02:48.050220 systemd[1]: Reached target swap.target - Swaps. Oct 19 09:02:48.050249 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 19 09:02:48.050283 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 19 09:02:48.050312 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 19 09:02:48.050340 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 19 09:02:48.050370 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Oct 19 09:02:48.050399 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 19 09:02:48.050428 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 19 09:02:48.050457 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Oct 19 09:02:48.050490 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Oct 19 09:02:48.050519 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Oct 19 09:02:48.050548 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Oct 19 09:02:48.050577 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 19 09:02:48.050605 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Oct 19 09:02:48.050634 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Oct 19 09:02:48.050667 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Oct 19 09:02:48.050695 systemd[1]: Listening on systemd-report-basic.socket - Report System Basic Metrics Socket. Oct 19 09:02:48.050724 systemd[1]: Listening on systemd-report-cgroup.socket - CGroup Report Varlink Socket. Oct 19 09:02:48.050755 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Oct 19 09:02:48.050784 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Oct 19 09:02:48.050813 systemd[1]: Listening on systemd-storage-block.socket - Simple Block Device Backed Storage Provider. Oct 19 09:02:48.050842 systemd[1]: Listening on systemd-storage-fs.socket - Simple File System Backed Storage Provider. Oct 19 09:02:48.050877 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 19 09:02:48.050914 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 19 09:02:48.050943 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 19 09:02:48.051006 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 19 09:02:48.051047 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 19 09:02:48.051077 systemd[1]: Mounting media.mount - External Media Directory... Oct 19 09:02:48.051376 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 19 09:02:48.052080 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 19 09:02:48.052112 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Oct 19 09:02:48.052142 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 19 09:02:48.052171 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 19 09:02:48.052210 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Oct 19 09:02:48.052240 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 19 09:02:48.052269 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 19 09:02:48.052298 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Oct 19 09:02:48.052328 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 19 09:02:48.052357 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 19 09:02:48.052392 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Oct 19 09:02:48.052423 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 19 09:02:48.052451 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 19 09:02:48.052482 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 Oct 19 09:02:48.052512 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 19 09:02:48.052548 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 19 09:02:48.052577 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 19 09:02:48.052615 systemd[1]: Reached target time-set.target - System Time Set. Oct 19 09:02:48.052644 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 19 09:02:48.052675 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 19 09:02:48.052706 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 19 09:02:48.052740 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 19 09:02:48.052774 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 19 09:02:48.052804 systemd[1]: Mounted media.mount - External Media Directory. Oct 19 09:02:48.052833 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 19 09:02:48.052866 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 19 09:02:48.052895 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 19 09:02:48.052925 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 19 09:02:48.052955 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 19 09:02:48.054093 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 19 09:02:48.054133 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 19 09:02:48.054161 kernel: fuse: init (API version 7.45) Oct 19 09:02:48.054191 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 19 09:02:48.054279 systemd-journald[1304]: Collecting audit messages is enabled. Oct 19 09:02:48.054330 systemd-journald[1304]: Journal started Oct 19 09:02:48.054378 systemd-journald[1304]: Runtime Journal (/run/log/journal/ec2f4b728800796b83ed417ad4977199) is 8M, max 75.2M, 67.2M free. Oct 19 09:02:47.575000 audit[1]: EVENT_LISTENER pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 Oct 19 09:02:47.866000 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' Oct 19 09:02:47.872000 audit: BPF prog-id=18 op=UNLOAD Oct 19 09:02:47.872000 audit: BPF prog-id=17 op=UNLOAD Oct 19 09:02:47.873000 audit: BPF prog-id=19 op=LOAD Oct 19 09:02:47.873000 audit: BPF prog-id=20 op=LOAD Oct 19 09:02:47.874000 audit: BPF prog-id=21 op=LOAD Oct 19 09:02:47.990000 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' Oct 19 09:02:48.010000 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' Oct 19 09:02:48.010000 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' Oct 19 09:02:48.029000 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' Oct 19 09:02:47.294158 systemd[1]: Queued start job for default target multi-user.target. Oct 19 09:02:47.315915 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Oct 19 09:02:47.316749 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 19 09:02:48.001198 systemd-modules-load[1305]: Using 2 probe threads Oct 19 09:02:48.038000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 19 09:02:48.038000 audit[1304]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=5 a1=fffffe029b60 a2=4000 a3=0 items=0 ppid=1 pid=1304 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) Oct 19 09:02:48.038000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 19 09:02:48.067575 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 19 09:02:48.078770 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 19 09:02:48.086000 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' Oct 19 09:02:48.090171 systemd[1]: Started systemd-journald.service - Journal Service. Oct 19 09:02:48.092271 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 19 09:02:48.095000 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' Oct 19 09:02:48.095000 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' Oct 19 09:02:48.094079 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 19 09:02:48.097467 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 19 09:02:48.102000 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' Oct 19 09:02:48.102000 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' Oct 19 09:02:48.097867 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 19 09:02:48.104096 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 19 09:02:48.106000 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' Oct 19 09:02:48.108238 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 19 09:02:48.111000 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' Oct 19 09:02:48.126925 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 19 09:02:48.134037 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 19 09:02:48.138982 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Oct 19 09:02:48.149325 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 19 09:02:48.157339 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 19 09:02:48.161198 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Oct 19 09:02:48.167531 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 19 09:02:48.177303 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 19 09:02:48.190125 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 19 09:02:48.196201 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 19 09:02:48.199000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:48.204227 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 19 09:02:48.262080 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 19 09:02:48.264000 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' Oct 19 09:02:48.265710 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 19 09:02:48.283593 systemd-journald[1304]: Time spent on flushing to /var/log/journal/ec2f4b728800796b83ed417ad4977199 is 39.347ms for 1170 entries. Oct 19 09:02:48.283593 systemd-journald[1304]: System Journal (/var/log/journal/ec2f4b728800796b83ed417ad4977199) is 8M, max 588.1M, 580.1M free. Oct 19 09:02:48.309000 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' Oct 19 09:02:48.339000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:48.310142 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 19 09:02:48.356687 systemd-journald[1304]: Received client request to flush runtime journal. Oct 19 09:02:48.361000 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' Oct 19 09:02:48.322689 systemd-tmpfiles[1316]: ACLs are not supported, ignoring. Oct 19 09:02:48.322714 systemd-tmpfiles[1316]: ACLs are not supported, ignoring. Oct 19 09:02:48.337258 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 19 09:02:48.359093 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 19 09:02:48.490000 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' Oct 19 09:02:48.488757 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 19 09:02:48.498198 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 19 09:02:48.572147 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 19 09:02:48.574000 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' Oct 19 09:02:48.657293 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 19 09:02:48.659000 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' Oct 19 09:02:48.668278 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Oct 19 09:02:48.676000 audit: BPF prog-id=22 op=LOAD Oct 19 09:02:48.678000 audit: BPF prog-id=23 op=LOAD Oct 19 09:02:48.678000 audit: BPF prog-id=24 op=LOAD Oct 19 09:02:48.680922 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Oct 19 09:02:48.687000 audit: BPF prog-id=25 op=LOAD Oct 19 09:02:48.690348 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 19 09:02:48.698445 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 19 09:02:48.703214 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 19 09:02:48.724000 audit: BPF prog-id=26 op=LOAD Oct 19 09:02:48.727000 audit: BPF prog-id=27 op=LOAD Oct 19 09:02:48.727000 audit: BPF prog-id=28 op=LOAD Oct 19 09:02:48.733161 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 19 09:02:48.745408 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Oct 19 09:02:48.782730 systemd-tmpfiles[1375]: ACLs are not supported, ignoring. Oct 19 09:02:48.785102 systemd-tmpfiles[1375]: ACLs are not supported, ignoring. Oct 19 09:02:48.794030 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 19 09:02:48.796000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:48.800704 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 19 09:02:48.804607 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Oct 19 09:02:48.804697 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 19 09:02:48.811546 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Oct 19 09:02:48.818228 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 19 09:02:48.828678 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 19 09:02:48.835903 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Oct 19 09:02:48.838689 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Oct 19 09:02:48.846005 kernel: tun: Universal TUN/TAP device driver, 1.6 Oct 19 09:02:48.850460 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 19 09:02:48.855325 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Oct 19 09:02:48.863262 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Oct 19 09:02:48.870265 systemd[1]: modprobe@tun.service: Deactivated successfully. Oct 19 09:02:48.872602 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Oct 19 09:02:48.876000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:48.876000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:48.880492 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1376 ((systemd-userd)) Oct 19 09:02:48.887396 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Oct 19 09:02:48.896000 audit: BPF prog-id=29 op=LOAD Oct 19 09:02:48.896000 audit: BPF prog-id=30 op=LOAD Oct 19 09:02:48.896000 audit: BPF prog-id=31 op=LOAD Oct 19 09:02:48.900484 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Oct 19 09:02:48.941507 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Oct 19 09:02:48.961278 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Oct 19 09:02:48.966000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdb-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:49.004198 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 19 09:02:49.008000 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' Oct 19 09:02:49.021062 kernel: loop4: detected capacity change from 0 to 44497 Oct 19 09:02:49.030017 kernel: loop4: p1 p2 p3 Oct 19 09:02:49.077186 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 19 09:02:49.087000 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' Oct 19 09:02:49.109838 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:49.110034 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:49.112085 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:49.113767 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:49.114013 systemd-confext[1388]: device-mapper: reload ioctl on loop4p1-51-verity (254:5) failed: Invalid argument Oct 19 09:02:49.131029 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:49.137816 systemd-nsresourced[1384]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Oct 19 09:02:49.151000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-nsresourced comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:49.141533 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Oct 19 09:02:49.270900 systemd-oomd[1373]: No swap; memory pressure usage will be degraded Oct 19 09:02:49.277450 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Oct 19 09:02:49.282000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-oomd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:49.364148 systemd-resolved[1374]: Positive Trust Anchors: Oct 19 09:02:49.364873 systemd-resolved[1374]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 19 09:02:49.365046 systemd-resolved[1374]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 19 09:02:49.365120 systemd-resolved[1374]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 19 09:02:49.395334 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 19 09:02:49.419180 systemd-resolved[1374]: Defaulting to hostname 'linux'. Oct 19 09:02:49.427000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:49.422816 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 19 09:02:49.428835 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 19 09:02:49.570606 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 19 09:02:49.572000 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' Oct 19 09:02:49.574000 audit: BPF prog-id=7 op=UNLOAD Oct 19 09:02:49.574000 audit: BPF prog-id=6 op=UNLOAD Oct 19 09:02:49.574000 audit: BPF prog-id=32 op=LOAD Oct 19 09:02:49.575000 audit: BPF prog-id=33 op=LOAD Oct 19 09:02:49.577547 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 19 09:02:49.874790 systemd-udevd[1409]: Using default interface naming scheme 'v261'. Oct 19 09:02:50.053108 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 19 09:02:50.055000 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' Oct 19 09:02:50.057000 audit: BPF prog-id=34 op=LOAD Oct 19 09:02:50.062151 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 19 09:02:50.292529 systemd-networkd[1411]: lo: Link UP Oct 19 09:02:50.292571 systemd-networkd[1411]: lo: Gained carrier Oct 19 09:02:50.296205 systemd[1]: Started systemd-networkd.service - Network Management. Oct 19 09:02:50.297000 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' Oct 19 09:02:50.299033 systemd[1]: Reached target network.target - Network. Oct 19 09:02:50.305202 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 19 09:02:50.316323 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Oct 19 09:02:50.336798 (udev-worker)[1420]: Network interface NamePolicy= disabled on kernel command line. Oct 19 09:02:50.411482 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 19 09:02:50.413000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-persistent-storage comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:50.422234 kernel: kauditd_printk_skb: 70 callbacks suppressed Oct 19 09:02:50.422312 kernel: audit: type=1130 audit(1792400570.413:155): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-persistent-storage comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:50.445184 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 19 09:02:50.496831 systemd-networkd[1411]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 19 09:02:50.502311 systemd-networkd[1411]: eth0: Link UP Oct 19 09:02:50.502697 systemd-networkd[1411]: eth0: Gained carrier Oct 19 09:02:50.517626 systemd-networkd[1411]: eth0: DHCPv4 address 172.31.24.189/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 19 09:02:50.686055 kernel: vmclock AMZNC10C:00: vmclock0: registered miscdev Oct 19 09:02:50.971740 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 09:02:51.087172 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Oct 19 09:02:51.095744 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Oct 19 09:02:51.124536 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 19 09:02:51.136894 kernel: loop4: detected capacity change from 0 to 44497 Oct 19 09:02:51.143275 kernel: loop4: p1 p2 p3 Oct 19 09:02:51.166076 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.166197 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:51.169452 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:51.169586 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:51.171418 (sd-merge)[1553]: device-mapper: reload ioctl on loop4p1-56-verity (254:5) failed: Invalid argument Oct 19 09:02:51.181084 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.225340 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Oct 19 09:02:51.228300 (sd-merge)[1553]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 19 09:02:51.232000 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' Oct 19 09:02:51.230021 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 19 09:02:51.243020 kernel: audit: type=1130 audit(1792400571.232:156): 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' Oct 19 09:02:51.254000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-confext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:51.249262 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Oct 19 09:02:51.264030 kernel: audit: type=1130 audit(1792400571.254:157): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-confext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:51.276355 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 19 09:02:51.298464 systemd-vconsole-setup[1545]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 19 09:02:51.309000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:51.307410 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 09:02:51.322039 kernel: audit: type=1130 audit(1792400571.309:158): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:51.334020 kernel: loop4: detected capacity change from 0 to 158624 Oct 19 09:02:51.349024 kernel: loop4: p1 p2 p3 Oct 19 09:02:51.370282 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.370402 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:51.372643 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:51.374152 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:51.374316 systemd-sysext[1563]: device-mapper: reload ioctl on loop4p1-60-verity (254:5) failed: Invalid argument Oct 19 09:02:51.386019 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.439140 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 09:02:51.479092 kernel: loop4: detected capacity change from 0 to 404352 Oct 19 09:02:51.491184 kernel: loop4: p1 p2 p3 Oct 19 09:02:51.500182 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.500307 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:51.500364 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:51.502015 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:51.503274 systemd-sysext[1563]: device-mapper: reload ioctl on loop4p1-65-verity (254:5) failed: Invalid argument Oct 19 09:02:51.509890 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.560049 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 09:02:51.606039 kernel: loop4: detected capacity change from 0 to 305992 Oct 19 09:02:51.614150 kernel: loop4: p1 p2 p3 Oct 19 09:02:51.625084 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.625209 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:51.627165 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:51.628580 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:51.628790 systemd-sysext[1563]: device-mapper: reload ioctl on loop4p1-70-verity (254:5) failed: Invalid argument Oct 19 09:02:51.635015 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.686024 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 09:02:51.724026 kernel: loop4: detected capacity change from 0 to 158624 Oct 19 09:02:51.735079 kernel: loop4: p1 p2 p3 Oct 19 09:02:51.745530 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.745628 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:51.745745 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:51.747423 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:51.748715 (sd-merge)[1589]: device-mapper: reload ioctl on loop4p1-75-verity (254:5) failed: Invalid argument Oct 19 09:02:51.756031 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.805215 systemd-networkd[1411]: eth0: Gained IPv6LL Oct 19 09:02:51.810591 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 09:02:51.810666 kernel: loop5: detected capacity change from 0 to 404352 Oct 19 09:02:51.827015 kernel: loop5: p1 p2 p3 Oct 19 09:02:51.827993 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Oct 19 09:02:51.830000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:51.832209 systemd[1]: Reached target network-online.target - Network is Online. Oct 19 09:02:51.838016 kernel: audit: type=1130 audit(1792400571.830:159): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:51.858017 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.858108 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:51.858179 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:51.860260 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:51.860305 (sd-merge)[1589]: device-mapper: reload ioctl on loop5p1-79-verity (254:6) failed: Invalid argument Oct 19 09:02:51.871220 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.925023 kernel: erofs (device dm-6): mounted with root inode @ nid 39. Oct 19 09:02:51.934033 kernel: loop6: detected capacity change from 0 to 305992 Oct 19 09:02:51.945037 kernel: loop6: p1 p2 p3 Oct 19 09:02:51.958368 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:51.958476 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 09:02:51.958554 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Oct 19 09:02:51.961915 kernel: device-mapper: ioctl: error adding target to table Oct 19 09:02:51.961745 (sd-merge)[1589]: device-mapper: reload ioctl on loop6p1-83-verity (254:7) failed: Invalid argument Oct 19 09:02:51.969048 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 09:02:52.015086 kernel: erofs (device dm-7): mounted with root inode @ nid 39. Oct 19 09:02:52.015320 (sd-merge)[1589]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 19 09:02:52.029270 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 19 09:02:52.034000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:52.048053 kernel: audit: type=1130 audit(1792400572.034:160): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 09:02:52.054218 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 19 09:02:52.111923 systemd-tmpfiles[1614]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 19 09:02:52.112074 systemd-tmpfiles[1614]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 19 09:02:52.112638 systemd-tmpfiles[1614]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 19 09:02:52.116677 systemd-tmpfiles[1614]: ACLs are not supported, ignoring. Oct 19 09:02:52.117462 systemd-tmpfiles[1614]: ACLs are not supported, ignoring. Oct 19 09:02:52.129191 systemd-tmpfiles[1614]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 19 09:02:52.129369 systemd-tmpfiles[1614]: Skipping /boot Oct 19 09:02:52.149129 systemd-tmpfiles[1614]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 19 09:02:52.149309 systemd-tmpfiles[1614]: Skipping /boot Oct 19 09:02:52.177270 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 19 09:02:52.176000 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' Oct 19 09:02:52.187029 kernel: audit: type=1130 audit(1792400572.176:161): 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' Oct 19 09:02:52.188476 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 19 09:02:52.202179 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 19 09:02:52.209416 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 19 09:02:52.216068 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 19 09:02:52.226779 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 19 09:02:52.270000 audit[1622]: AUDIT1127 pid=1622 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' Oct 19 09:02:52.279081 kernel: audit: type=1127 audit(1792400572.270:162): pid=1622 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' Oct 19 09:02:52.285000 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' Oct 19 09:02:52.283483 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 19 09:02:52.292016 kernel: audit: type=1130 audit(1792400572.285:163): 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' Oct 19 09:02:52.327233 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 19 09:02:52.329000 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' Oct 19 09:02:52.337061 kernel: audit: type=1130 audit(1792400572.329:164): 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' Oct 19 09:02:52.456835 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 19 09:02:52.459000 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' Oct 19 09:02:52.460619 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt skipped, unmet condition check ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt Oct 19 09:02:52.525000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 19 09:02:52.525000 audit[1646]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffcc052a50 a2=420 a3=0 items=0 ppid=1618 pid=1646 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 19 09:02:52.525000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 19 09:02:52.527283 augenrules[1646]: No rules Oct 19 09:02:52.529230 systemd[1]: audit-rules.service: Deactivated successfully. Oct 19 09:02:52.529850 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 19 09:02:55.725585 ldconfig[1620]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 19 09:02:55.737842 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 19 09:02:55.742983 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 19 09:02:55.774746 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 19 09:02:55.777747 systemd[1]: Reached target sysinit.target - System Initialization. Oct 19 09:02:55.780287 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 19 09:02:55.783050 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 19 09:02:55.786109 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 19 09:02:55.788626 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 19 09:02:55.792054 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Oct 19 09:02:55.795231 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Oct 19 09:02:55.797726 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 19 09:02:55.800599 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Oct 19 09:02:55.800670 systemd[1]: Reached target paths.target - Path Units. Oct 19 09:02:55.802688 systemd[1]: Reached target timers.target - Timer Units. Oct 19 09:02:55.806444 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 19 09:02:55.811449 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 19 09:02:55.817576 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 19 09:02:55.824124 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 19 09:02:55.827811 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Oct 19 09:02:55.831355 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 19 09:02:55.835295 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 19 09:02:55.837782 systemd[1]: Reached target sockets.target - Socket Units. Oct 19 09:02:55.839995 systemd[1]: Reached target basic.target - Basic System. Oct 19 09:02:55.842167 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Oct 19 09:02:55.842220 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Oct 19 09:02:55.844051 systemd[1]: Starting containerd.service - containerd container runtime... Oct 19 09:02:55.850316 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Oct 19 09:02:55.860288 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 19 09:02:55.863818 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 19 09:02:55.873822 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 19 09:02:55.879259 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 19 09:02:55.882190 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Oct 19 09:02:55.885570 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 19 09:02:55.894361 systemd[1]: Started ntpd.service - Network Time Service. Oct 19 09:02:55.904316 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 19 09:02:55.914517 systemd[1]: Starting setup-oem.service - Setup OEM... Oct 19 09:02:55.925310 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 19 09:02:55.932488 jq[1660]: false Oct 19 09:02:55.933225 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 19 09:02:55.950283 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 19 09:02:55.952703 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Oct 19 09:02:55.964500 systemd[1]: Starting update-engine.service - Update Engine... Oct 19 09:02:55.975325 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 19 09:02:55.984929 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 19 09:02:55.986601 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 19 09:02:56.023838 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 19 09:02:56.024435 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 19 09:02:56.045889 extend-filesystems[1661]: Found /dev/nvme0n1p6 Oct 19 09:02:56.066043 motdgen[1687]: /oem/oem-release: line 2: EC2: command not found Oct 19 09:02:56.097174 jq[1673]: true Oct 19 09:02:56.107752 systemd[1]: motdgen.service: Deactivated successfully. Oct 19 09:02:56.108478 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 19 09:02:56.148614 extend-filesystems[1661]: Found /dev/nvme0n1p9 Oct 19 09:02:56.157180 update_engine[1672]: I20261019 09:02:56.156713 1672 main.cc:92] Flatcar Update Engine starting Oct 19 09:02:56.164213 ntpd[1663]: ntpd 4.2.8p18@1.4062-o Mon Oct 19 06:45:41 UTC 2026 (1): Starting Oct 19 09:02:56.169007 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: ntpd 4.2.8p18@1.4062-o Mon Oct 19 06:45:41 UTC 2026 (1): Starting Oct 19 09:02:56.169007 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 19 09:02:56.169007 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: ---------------------------------------------------- Oct 19 09:02:56.169007 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: ntp-4 is maintained by Network Time Foundation, Oct 19 09:02:56.169007 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 19 09:02:56.169007 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: corporation. Support and training for ntp-4 are Oct 19 09:02:56.169007 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: available at https://www.nwtime.org/support Oct 19 09:02:56.169007 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: ---------------------------------------------------- Oct 19 09:02:56.168058 ntpd[1663]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 19 09:02:56.168089 ntpd[1663]: ---------------------------------------------------- Oct 19 09:02:56.168107 ntpd[1663]: ntp-4 is maintained by Network Time Foundation, Oct 19 09:02:56.169530 extend-filesystems[1661]: Checking size of /dev/nvme0n1p9 Oct 19 09:02:56.168125 ntpd[1663]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 19 09:02:56.168142 ntpd[1663]: corporation. Support and training for ntp-4 are Oct 19 09:02:56.168158 ntpd[1663]: available at https://www.nwtime.org/support Oct 19 09:02:56.168175 ntpd[1663]: ---------------------------------------------------- Oct 19 09:02:56.186581 ntpd[1663]: proto: precision = 0.096 usec (-23) Oct 19 09:02:56.188917 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: proto: precision = 0.096 usec (-23) Oct 19 09:02:56.188917 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: basedate set to 2026-10-07 Oct 19 09:02:56.188917 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: gps base set to 2026-10-11 (week 2440) Oct 19 09:02:56.188917 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: Listen and drop on 0 v6wildcard [::]:123 Oct 19 09:02:56.188917 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 19 09:02:56.188917 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: Listen normally on 2 lo 127.0.0.1:123 Oct 19 09:02:56.188917 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: Listen normally on 3 eth0 172.31.24.189:123 Oct 19 09:02:56.188917 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: Listen normally on 4 lo [::1]:123 Oct 19 09:02:56.188917 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: Listen normally on 5 eth0 [fe80::4ff:d4ff:fe15:de31%2]:123 Oct 19 09:02:56.188917 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: Listening on routing socket on fd #22 for interface updates Oct 19 09:02:56.187067 ntpd[1663]: basedate set to 2026-10-07 Oct 19 09:02:56.187098 ntpd[1663]: gps base set to 2026-10-11 (week 2440) Oct 19 09:02:56.187306 ntpd[1663]: Listen and drop on 0 v6wildcard [::]:123 Oct 19 09:02:56.187353 ntpd[1663]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 19 09:02:56.187676 ntpd[1663]: Listen normally on 2 lo 127.0.0.1:123 Oct 19 09:02:56.187723 ntpd[1663]: Listen normally on 3 eth0 172.31.24.189:123 Oct 19 09:02:56.187779 ntpd[1663]: Listen normally on 4 lo [::1]:123 Oct 19 09:02:56.187829 ntpd[1663]: Listen normally on 5 eth0 [fe80::4ff:d4ff:fe15:de31%2]:123 Oct 19 09:02:56.187877 ntpd[1663]: Listening on routing socket on fd #22 for interface updates Oct 19 09:02:56.215234 jq[1706]: true Oct 19 09:02:56.227744 systemd[1]: Finished setup-oem.service - Setup OEM. Oct 19 09:02:56.233828 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Oct 19 09:02:56.245017 dbus-daemon[1659]: [system] SELinux support is enabled Oct 19 09:02:56.249295 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 19 09:02:56.252206 systemd[1]: system-cloudinit@usr-share-coreos-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/coreos/cloud-config.yml skipped, unmet condition check ConditionFileNotEmpty=/usr/share/coreos/cloud-config.yml Oct 19 09:02:56.252252 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 19 09:02:56.255192 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline skipped, unmet condition check ConditionKernelCommandLine=cloud-config-url Oct 19 09:02:56.255229 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 19 09:02:56.266113 extend-filesystems[1661]: Resized partition /dev/nvme0n1p9 Oct 19 09:02:56.267236 ntpd[1663]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 09:02:56.271715 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 09:02:56.271715 ntpd[1663]: 19 Oct 09:02:56 ntpd[1663]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 09:02:56.267285 ntpd[1663]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 09:02:56.293336 dbus-daemon[1659]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.2' (uid=244 pid=1411 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Oct 19 09:02:56.308363 dbus-daemon[1659]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 19 09:02:56.313251 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Oct 19 09:02:56.318824 systemd[1]: Started update-engine.service - Update Engine. Oct 19 09:02:56.324300 extend-filesystems[1722]: resize2fs 1.47.4 (6-Mar-2025) Oct 19 09:02:56.326753 update_engine[1672]: I20261019 09:02:56.321257 1672 update_check_scheduler.cc:74] Next update check in 3m37s Oct 19 09:02:56.327184 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 19 09:02:56.369118 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 1617920 to 2604027 blocks Oct 19 09:02:56.372595 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 19 09:02:56.429466 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 2604027 Oct 19 09:02:56.499087 extend-filesystems[1722]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Oct 19 09:02:56.499087 extend-filesystems[1722]: old_desc_blocks = 1, new_desc_blocks = 2 Oct 19 09:02:56.499087 extend-filesystems[1722]: The filesystem on /dev/nvme0n1p9 is now 2604027 (4k) blocks long. Oct 19 09:02:56.488052 systemd-logind[1668]: Watching system buttons on /dev/input/event0 (Power Button) Oct 19 09:02:56.515951 coreos-metadata[1658]: Oct 19 09:02:56.491 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 19 09:02:56.516577 extend-filesystems[1661]: Resized filesystem in /dev/nvme0n1p9 Oct 19 09:02:56.488109 systemd-logind[1668]: Watching system buttons on /dev/input/event1 (Sleep Button) Oct 19 09:02:56.492521 systemd-logind[1668]: New seat seat0. Oct 19 09:02:56.498645 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 19 09:02:56.499711 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 19 09:02:56.526633 coreos-metadata[1658]: Oct 19 09:02:56.524 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Oct 19 09:02:56.527016 systemd[1]: Started systemd-logind.service - User Login Management. Oct 19 09:02:56.551260 coreos-metadata[1658]: Oct 19 09:02:56.550 INFO Fetch successful Oct 19 09:02:56.551260 coreos-metadata[1658]: Oct 19 09:02:56.550 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Oct 19 09:02:56.564684 bash[1746]: Updated "/home/core/.ssh/authorized_keys" Oct 19 09:02:56.570711 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 19 09:02:56.578296 coreos-metadata[1658]: Oct 19 09:02:56.574 INFO Fetch successful Oct 19 09:02:56.578296 coreos-metadata[1658]: Oct 19 09:02:56.574 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Oct 19 09:02:56.578296 coreos-metadata[1658]: Oct 19 09:02:56.574 INFO Fetch successful Oct 19 09:02:56.578296 coreos-metadata[1658]: Oct 19 09:02:56.574 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Oct 19 09:02:56.584426 systemd[1]: Starting sshkeys.service... Oct 19 09:02:56.590084 coreos-metadata[1658]: Oct 19 09:02:56.579 INFO Fetch successful Oct 19 09:02:56.590084 coreos-metadata[1658]: Oct 19 09:02:56.589 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Oct 19 09:02:56.590084 coreos-metadata[1658]: Oct 19 09:02:56.589 INFO Fetch failed with 404: resource not found Oct 19 09:02:56.590084 coreos-metadata[1658]: Oct 19 09:02:56.589 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Oct 19 09:02:56.603324 coreos-metadata[1658]: Oct 19 09:02:56.603 INFO Fetch successful Oct 19 09:02:56.603324 coreos-metadata[1658]: Oct 19 09:02:56.603 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Oct 19 09:02:56.604338 coreos-metadata[1658]: Oct 19 09:02:56.603 INFO Fetch successful Oct 19 09:02:56.604338 coreos-metadata[1658]: Oct 19 09:02:56.603 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Oct 19 09:02:56.605406 coreos-metadata[1658]: Oct 19 09:02:56.604 INFO Fetch successful Oct 19 09:02:56.605406 coreos-metadata[1658]: Oct 19 09:02:56.604 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Oct 19 09:02:56.610114 coreos-metadata[1658]: Oct 19 09:02:56.607 INFO Fetch successful Oct 19 09:02:56.610114 coreos-metadata[1658]: Oct 19 09:02:56.607 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Oct 19 09:02:56.618233 coreos-metadata[1658]: Oct 19 09:02:56.615 INFO Fetch successful Oct 19 09:02:56.715749 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Oct 19 09:02:56.730728 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Oct 19 09:02:56.771488 amazon-ssm-agent[1718]: Initializing new seelog logger Oct 19 09:02:56.772116 amazon-ssm-agent[1718]: New Seelog Logger Creation Complete Oct 19 09:02:56.772116 amazon-ssm-agent[1718]: 2026/10/19 09:02:56 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 09:02:56.772116 amazon-ssm-agent[1718]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 09:02:56.772245 amazon-ssm-agent[1718]: 2026/10/19 09:02:56 processing appconfig overrides Oct 19 09:02:56.774500 amazon-ssm-agent[1718]: 2026/10/19 09:02:56 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 09:02:56.774500 amazon-ssm-agent[1718]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 09:02:56.774500 amazon-ssm-agent[1718]: 2026/10/19 09:02:56 processing appconfig overrides Oct 19 09:02:56.786245 amazon-ssm-agent[1718]: 2026/10/19 09:02:56 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 09:02:56.786245 amazon-ssm-agent[1718]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 09:02:56.786245 amazon-ssm-agent[1718]: 2026/10/19 09:02:56 processing appconfig overrides Oct 19 09:02:56.789539 amazon-ssm-agent[1718]: 2026-10-19 09:02:56.7726 INFO Proxy environment variables: Oct 19 09:02:56.817695 amazon-ssm-agent[1718]: 2026/10/19 09:02:56 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 09:02:56.818576 amazon-ssm-agent[1718]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 09:02:56.822278 amazon-ssm-agent[1718]: 2026/10/19 09:02:56 processing appconfig overrides Oct 19 09:02:56.827131 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Oct 19 09:02:56.844911 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Oct 19 09:02:56.889873 (etcd-wrapper)[1790]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Oct 19 09:02:56.890988 amazon-ssm-agent[1718]: 2026-10-19 09:02:56.7726 INFO https_proxy: Oct 19 09:02:56.951935 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Oct 19 09:02:56.973442 dbus-daemon[1659]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 19 09:02:56.978193 dbus-daemon[1659]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1725 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Oct 19 09:02:56.991764 amazon-ssm-agent[1718]: 2026-10-19 09:02:56.7726 INFO http_proxy: Oct 19 09:02:57.000639 systemd[1]: Starting polkit.service - Authorization Manager... Oct 19 09:02:57.020998 coreos-metadata[1774]: Oct 19 09:02:57.018 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 19 09:02:57.024821 coreos-metadata[1774]: Oct 19 09:02:57.024 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Oct 19 09:02:57.024821 coreos-metadata[1774]: Oct 19 09:02:57.024 INFO Fetch successful Oct 19 09:02:57.024821 coreos-metadata[1774]: Oct 19 09:02:57.024 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Oct 19 09:02:57.028836 coreos-metadata[1774]: Oct 19 09:02:57.028 INFO Fetch successful Oct 19 09:02:57.035827 unknown[1774]: wrote ssh authorized keys file for user: core Oct 19 09:02:57.099090 amazon-ssm-agent[1718]: 2026-10-19 09:02:56.7726 INFO no_proxy: Oct 19 09:02:57.147504 update-ssh-keys[1807]: Updated "/home/core/.ssh/authorized_keys" Oct 19 09:02:57.150879 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Oct 19 09:02:57.175171 systemd[1]: Finished sshkeys.service. Oct 19 09:02:57.203038 amazon-ssm-agent[1718]: 2026-10-19 09:02:56.7729 INFO Checking if agent identity type OnPrem can be assumed Oct 19 09:02:57.299200 amazon-ssm-agent[1718]: 2026-10-19 09:02:56.7842 INFO Checking if agent identity type EC2 can be assumed Oct 19 09:02:57.341704 sshd_keygen[1701]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Oct 19 09:02:57.404879 amazon-ssm-agent[1718]: 2026-10-19 09:02:57.0872 INFO Agent will take identity from EC2 Oct 19 09:02:57.505645 amazon-ssm-agent[1718]: 2026-10-19 09:02:57.1329 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.3.0.0 Oct 19 09:02:57.525152 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 19 09:02:57.539496 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 19 09:02:57.606012 amazon-ssm-agent[1718]: 2026-10-19 09:02:57.1329 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Oct 19 09:02:57.628332 locksmithd[1727]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 19 09:02:57.650644 systemd[1]: issuegen.service: Deactivated successfully. Oct 19 09:02:57.653475 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 19 09:02:57.669212 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 19 09:02:57.682733 polkitd[1802]: Started polkitd version 126 Oct 19 09:02:57.712939 amazon-ssm-agent[1718]: 2026-10-19 09:02:57.1329 INFO [amazon-ssm-agent] Starting Core Agent Oct 19 09:02:57.755850 polkitd[1802]: Loading rules from directory /etc/polkit-1/rules.d Oct 19 09:02:57.759177 polkitd[1802]: Loading rules from directory /run/polkit-1/rules.d Oct 19 09:02:57.759261 polkitd[1802]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Oct 19 09:02:57.759284 polkitd[1802]: Loading rules from directory /usr/local/share/polkit-1/rules.d Oct 19 09:02:57.759316 polkitd[1802]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Oct 19 09:02:57.759335 polkitd[1802]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 19 09:02:57.772159 polkitd[1802]: Finished loading, compiling and executing 5 rules Oct 19 09:02:57.773616 systemd[1]: Started polkit.service - Authorization Manager. Oct 19 09:02:57.797673 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 19 09:02:57.813347 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 19 09:02:57.816105 amazon-ssm-agent[1718]: 2026-10-19 09:02:57.1329 INFO [amazon-ssm-agent] Registrar detected. Attempting registration Oct 19 09:02:57.826815 dbus-daemon[1659]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 19 09:02:57.830286 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 19 09:02:57.833717 systemd[1]: Reached target getty.target - Login Prompts. Oct 19 09:02:57.851738 polkitd[1802]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 19 09:02:57.876077 containerd[1695]: time="2026-10-19T09:02:57Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Oct 19 09:02:57.876077 containerd[1695]: time="2026-10-19T09:02:57Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="32.124µs" Oct 19 09:02:57.898317 containerd[1695]: time="2026-10-19T09:02:57.894788246Z" level=info msg="starting containerd" revision=1294c24a7da8e5a793ed378161673abe94118892 version=v2.3.5 Oct 19 09:02:57.900505 containerd[1695]: time="2026-10-19T09:02:57.899376038Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 19 09:02:57.900505 containerd[1695]: time="2026-10-19T09:02:57.899848382Z" level=warning msg="failed check for fsverity support" error="enable fsverity failed: operation not supported" path=/var/lib/containerd/io.containerd.content.v1.content Oct 19 09:02:57.900505 containerd[1695]: time="2026-10-19T09:02:57.899905958Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 19 09:02:57.900505 containerd[1695]: time="2026-10-19T09:02:57.899936486Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 19 09:02:57.900505 containerd[1695]: time="2026-10-19T09:02:57.900310958Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 19 09:02:57.900505 containerd[1695]: time="2026-10-19T09:02:57.900379706Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 19 09:02:57.910320 containerd[1695]: time="2026-10-19T09:02:57.909604442Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Oct 19 09:02:57.910320 containerd[1695]: time="2026-10-19T09:02:57.909678386Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 19 09:02:57.910320 containerd[1695]: time="2026-10-19T09:02:57.909909986Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 19 09:02:57.910661 containerd[1695]: time="2026-10-19T09:02:57.909945506Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 19 09:02:57.913578 containerd[1695]: time="2026-10-19T09:02:57.913488638Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 19 09:02:57.913795 containerd[1695]: time="2026-10-19T09:02:57.913749566Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 19 09:02:57.916120 containerd[1695]: time="2026-10-19T09:02:57.913909994Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 19 09:02:57.918043 containerd[1695]: time="2026-10-19T09:02:57.916305578Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 19 09:02:57.918043 containerd[1695]: time="2026-10-19T09:02:57.916939598Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 19 09:02:57.918043 containerd[1695]: time="2026-10-19T09:02:57.917311094Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 19 09:02:57.918043 containerd[1695]: time="2026-10-19T09:02:57.917857286Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 19 09:02:57.921009 amazon-ssm-agent[1718]: 2026-10-19 09:02:57.1329 INFO [Registrar] Starting registrar module Oct 19 09:02:57.924084 containerd[1695]: time="2026-10-19T09:02:57.917952794Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 19 09:02:57.924084 containerd[1695]: time="2026-10-19T09:02:57.923820086Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 19 09:02:57.926171 containerd[1695]: time="2026-10-19T09:02:57.926098610Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 19 09:02:57.926565 containerd[1695]: time="2026-10-19T09:02:57.926509166Z" level=info msg="metadata content store policy set" policy=shared Oct 19 09:02:57.968692 containerd[1695]: time="2026-10-19T09:02:57.968568998Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 19 09:02:57.968833 containerd[1695]: time="2026-10-19T09:02:57.968762558Z" level=info msg="loading plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Oct 19 09:02:57.970796 containerd[1695]: time="2026-10-19T09:02:57.968832770Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Oct 19 09:02:57.970935 containerd[1695]: time="2026-10-19T09:02:57.970797458Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 19 09:02:57.970935 containerd[1695]: time="2026-10-19T09:02:57.970857254Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 19 09:02:57.970935 containerd[1695]: time="2026-10-19T09:02:57.970881086Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 19 09:02:57.971149 containerd[1695]: time="2026-10-19T09:02:57.970932890Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 19 09:02:57.971149 containerd[1695]: time="2026-10-19T09:02:57.970958558Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 19 09:02:57.971242 containerd[1695]: time="2026-10-19T09:02:57.971172590Z" level=info msg="built-in NRI default validator is disabled" Oct 19 09:02:57.974013 containerd[1695]: time="2026-10-19T09:02:57.973556018Z" level=info msg="runtime interface created" Oct 19 09:02:57.974013 containerd[1695]: time="2026-10-19T09:02:57.973645118Z" level=info msg="created NRI interface" Oct 19 09:02:57.974013 containerd[1695]: time="2026-10-19T09:02:57.973694186Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 19 09:02:57.974013 containerd[1695]: time="2026-10-19T09:02:57.973754750Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 19 09:02:57.974013 containerd[1695]: time="2026-10-19T09:02:57.973828814Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 19 09:02:57.974013 containerd[1695]: time="2026-10-19T09:02:57.973857710Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 19 09:02:57.993269 containerd[1695]: time="2026-10-19T09:02:57.993181814Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Oct 19 09:02:57.993648 containerd[1695]: time="2026-10-19T09:02:57.993575018Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 19 09:02:57.993748 containerd[1695]: time="2026-10-19T09:02:57.993651278Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 19 09:02:57.993748 containerd[1695]: time="2026-10-19T09:02:57.993686834Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 19 09:02:57.993748 containerd[1695]: time="2026-10-19T09:02:57.993715766Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 19 09:02:57.993748 containerd[1695]: time="2026-10-19T09:02:57.993739406Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 19 09:02:57.993907 containerd[1695]: time="2026-10-19T09:02:57.993764510Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 19 09:02:57.993907 containerd[1695]: time="2026-10-19T09:02:57.993787922Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 19 09:02:57.993907 containerd[1695]: time="2026-10-19T09:02:57.993815822Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 19 09:02:57.996996 containerd[1695]: time="2026-10-19T09:02:57.996187766Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 19 09:02:57.996996 containerd[1695]: time="2026-10-19T09:02:57.996333230Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 19 09:02:57.996996 containerd[1695]: time="2026-10-19T09:02:57.996374126Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 19 09:02:57.996996 containerd[1695]: time="2026-10-19T09:02:57.996425678Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 19 09:02:57.996996 containerd[1695]: time="2026-10-19T09:02:57.996453482Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 19 09:02:57.996996 containerd[1695]: time="2026-10-19T09:02:57.996475634Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 19 09:02:57.996996 containerd[1695]: time="2026-10-19T09:02:57.996531878Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 19 09:02:57.996996 containerd[1695]: time="2026-10-19T09:02:57.996556022Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 19 09:02:57.996996 containerd[1695]: time="2026-10-19T09:02:57.996931310Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 19 09:02:57.997404 containerd[1695]: time="2026-10-19T09:02:57.997025210Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Oct 19 09:02:57.997404 containerd[1695]: time="2026-10-19T09:02:57.997353410Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 19 09:02:57.999174 containerd[1695]: time="2026-10-19T09:02:57.999046274Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 19 09:02:57.999296 containerd[1695]: time="2026-10-19T09:02:57.999173846Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 19 09:02:57.999395 containerd[1695]: time="2026-10-19T09:02:57.999333146Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 19 09:02:58.007006 containerd[1695]: time="2026-10-19T09:02:58.001324834Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 19 09:02:58.007006 containerd[1695]: time="2026-10-19T09:02:58.006262822Z" level=info msg="Start snapshots syncer" Oct 19 09:02:58.007006 containerd[1695]: time="2026-10-19T09:02:58.006692686Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 19 09:02:58.019424 amazon-ssm-agent[1718]: 2026-10-19 09:02:57.1379 INFO [EC2Identity] Checking disk for registration info Oct 19 09:02:58.022000 containerd[1695]: time="2026-10-19T09:02:58.021758962Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"statsCollectPeriod\":\"\",\"statsRetentionPeriod\":\"\",\"enableCRIU\":true,\"enableExperimentalRestoreViaCreate\":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\"}" Oct 19 09:02:58.022730 containerd[1695]: time="2026-10-19T09:02:58.021954514Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 19 09:02:58.023020 containerd[1695]: time="2026-10-19T09:02:58.022946890Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 19 09:02:58.023327 containerd[1695]: time="2026-10-19T09:02:58.023265022Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 19 09:02:58.023403 containerd[1695]: time="2026-10-19T09:02:58.023338462Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 19 09:02:58.023403 containerd[1695]: time="2026-10-19T09:02:58.023367082Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 19 09:02:58.023483 containerd[1695]: time="2026-10-19T09:02:58.023397538Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 19 09:02:58.023483 containerd[1695]: time="2026-10-19T09:02:58.023426422Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 19 09:02:58.023483 containerd[1695]: time="2026-10-19T09:02:58.023468530Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 19 09:02:58.023617 containerd[1695]: time="2026-10-19T09:02:58.023497126Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 19 09:02:58.023617 containerd[1695]: time="2026-10-19T09:02:58.023533750Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 19 09:02:58.023617 containerd[1695]: time="2026-10-19T09:02:58.023556814Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 19 09:02:58.023617 containerd[1695]: time="2026-10-19T09:02:58.023580442Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 19 09:02:58.023794 containerd[1695]: time="2026-10-19T09:02:58.023622238Z" level=info msg="Connect containerd service" Oct 19 09:02:58.023794 containerd[1695]: time="2026-10-19T09:02:58.023677834Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 19 09:02:58.037014 containerd[1695]: time="2026-10-19T09:02:58.035044990Z" level=warning 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" Oct 19 09:02:58.051175 systemd-resolved[1374]: System hostname changed to 'ip-172-31-24-189'. Oct 19 09:02:58.053314 systemd-hostnamed[1725]: Hostname set to (transient) Oct 19 09:02:58.120104 amazon-ssm-agent[1718]: 2026-10-19 09:02:57.1380 INFO [EC2Identity] No registration info found for ec2 instance, attempting registration Oct 19 09:02:58.156187 amazon-ssm-agent[1718]: 2026/10/19 09:02:58 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 09:02:58.156187 amazon-ssm-agent[1718]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 09:02:58.156187 amazon-ssm-agent[1718]: 2026/10/19 09:02:58 processing appconfig overrides Oct 19 09:02:58.185402 amazon-ssm-agent[1718]: 2026-10-19 09:02:57.1380 INFO [EC2Identity] Generating registration keypair Oct 19 09:02:58.185402 amazon-ssm-agent[1718]: 2026-10-19 09:02:58.1155 INFO [EC2Identity] Checking write access before registering Oct 19 09:02:58.185402 amazon-ssm-agent[1718]: 2026-10-19 09:02:58.1166 INFO [EC2Identity] Registering EC2 instance with Systems Manager Oct 19 09:02:58.185402 amazon-ssm-agent[1718]: 2026-10-19 09:02:58.1546 INFO [EC2Identity] EC2 registration was successful. Oct 19 09:02:58.185402 amazon-ssm-agent[1718]: 2026-10-19 09:02:58.1547 INFO [amazon-ssm-agent] Registration attempted. Resuming core agent startup. Oct 19 09:02:58.185402 amazon-ssm-agent[1718]: 2026-10-19 09:02:58.1548 INFO [CredentialRefresher] credentialRefresher has started Oct 19 09:02:58.185402 amazon-ssm-agent[1718]: 2026-10-19 09:02:58.1549 INFO [CredentialRefresher] Starting credentials refresher loop Oct 19 09:02:58.185402 amazon-ssm-agent[1718]: 2026-10-19 09:02:58.1846 INFO EC2RoleProvider Successfully connected with instance profile role credentials Oct 19 09:02:58.185402 amazon-ssm-agent[1718]: 2026-10-19 09:02:58.1850 INFO [CredentialRefresher] Credentials ready Oct 19 09:02:58.219594 amazon-ssm-agent[1718]: 2026-10-19 09:02:58.1852 INFO [CredentialRefresher] Next credential rotation will be in 29.9999898039 minutes Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660152233Z" level=info msg="loading plugin" id=io.containerd.server.v1.ttrpc type=io.containerd.server.v1 Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660291181Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660309757Z" level=info msg="Start subscribing containerd event" Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660371797Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-prometheus type=io.containerd.metrics.v1 Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660379549Z" level=info msg="Start stats collector" Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660442981Z" level=info msg="Start recovering state" Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660436741Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-otel type=io.containerd.metrics.v1 Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660553225Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc type=io.containerd.server.v1 Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660569977Z" level=info msg="Start event monitor" Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660594961Z" level=info msg="Start cni network conf syncer for default" Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660612757Z" level=info msg="Start streaming server" Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660632089Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660647737Z" level=info msg="runtime interface starting up..." Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660662053Z" level=info msg="starting plugins..." Oct 19 09:02:58.660850 containerd[1695]: time="2026-10-19T09:02:58.660687637Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 19 09:02:58.677379 containerd[1695]: time="2026-10-19T09:02:58.677290885Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Oct 19 09:02:58.677379 containerd[1695]: time="2026-10-19T09:02:58.677363233Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Oct 19 09:02:58.677741 containerd[1695]: time="2026-10-19T09:02:58.677392189Z" level=info msg="loading plugin" id=io.containerd.http.v1.pprof type=io.containerd.http.v1 Oct 19 09:02:58.677830 containerd[1695]: time="2026-10-19T09:02:58.677791537Z" level=info msg="loading plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Oct 19 09:02:58.677885 containerd[1695]: time="2026-10-19T09:02:58.677833405Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Oct 19 09:02:58.678099 containerd[1695]: time="2026-10-19T09:02:58.678062545Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 19 09:02:58.678161 containerd[1695]: time="2026-10-19T09:02:58.678114001Z" level=info msg="starting GRPC server" address=/run/containerd/containerd.sock gid=0 uid=0 Oct 19 09:02:58.678302 containerd[1695]: time="2026-10-19T09:02:58.678203053Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 19 09:02:58.678358 containerd[1695]: time="2026-10-19T09:02:58.678304705Z" level=info msg="containerd successfully booted in 0.805553s" Oct 19 09:02:58.678540 systemd[1]: Started containerd.service - containerd container runtime. Oct 19 09:02:58.686331 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 19 09:02:58.705357 (dockerd)[1953]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Oct 19 09:02:59.212292 amazon-ssm-agent[1718]: 2026-10-19 09:02:59.2121 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Oct 19 09:02:59.313208 amazon-ssm-agent[1718]: 2026-10-19 09:02:59.2133 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:1956) started Oct 19 09:02:59.413577 amazon-ssm-agent[1718]: 2026-10-19 09:02:59.2133 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Oct 19 09:03:02.056751 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 19 09:03:02.072926 systemd[1]: Started sshd@0-1-172.31.24.189:22-20.31.226.197:48538.service - OpenSSH per-connection server daemon (20.31.226.197:48538). Oct 19 09:03:02.082838 dockerd[1953]: time="2026-10-19T09:03:02.082705298Z" level=info msg="Starting up" Oct 19 09:03:02.096139 dockerd[1953]: time="2026-10-19T09:03:02.096084926Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 19 09:03:02.096715 dockerd[1953]: time="2026-10-19T09:03:02.096474134Z" level=info msg="CDI directory does not exist, skipping" dir=/etc/cdi Oct 19 09:03:02.096715 dockerd[1953]: time="2026-10-19T09:03:02.096503342Z" level=info msg="CDI directory does not exist, skipping" dir=/var/run/cdi Oct 19 09:03:02.125330 dockerd[1953]: time="2026-10-19T09:03:02.125223339Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 19 09:03:02.130810 dockerd[1953]: time="2026-10-19T09:03:02.129885231Z" level=warning msg="failed check for fsverity support" error="enable fsverity failed: operation not supported" path=/var/lib/docker/plugins/storage Oct 19 09:03:02.155091 dockerd[1953]: time="2026-10-19T09:03:02.155026395Z" level=info msg="Loading containers: start." Oct 19 09:03:02.155206 dockerd[1953]: time="2026-10-19T09:03:02.155119887Z" level=info msg="NRI is disabled" Oct 19 09:03:02.155206 dockerd[1953]: time="2026-10-19T09:03:02.155140611Z" level=info msg="Starting daemon with containerd snapshotter integration enabled" Oct 19 09:03:02.184003 dockerd[1953]: time="2026-10-19T09:03:02.183637071Z" level=info msg="Restoring containers: start." Oct 19 09:03:02.265196 dockerd[1953]: time="2026-10-19T09:03:02.262938615Z" level=info msg="Deleting nftables IPv4 rules" error="running nft: /dev/stdin:1:17-30: Error: Could not process rule: No such file or directory\ndelete table ip docker-bridges\n ^^^^^^^^^^^^^^\n exit status 1" Oct 19 09:03:02.270435 dockerd[1953]: time="2026-10-19T09:03:02.270364803Z" level=info msg="Deleting nftables IPv6 rules" error="running nft: /dev/stdin:1:18-31: Error: Could not process rule: No such file or directory\ndelete table ip6 docker-bridges\n ^^^^^^^^^^^^^^\n exit status 1" Oct 19 09:03:02.719024 kernel: Initializing XFRM netlink socket Oct 19 09:03:02.763456 (udev-worker)[1995]: Network interface NamePolicy= disabled on kernel command line. Oct 19 09:03:02.825156 systemd-networkd[1411]: docker0: Link UP Oct 19 09:03:02.850509 dockerd[1953]: time="2026-10-19T09:03:02.850241826Z" level=info msg="Loading containers: done." Oct 19 09:03:02.874800 dockerd[1953]: time="2026-10-19T09:03:02.874745346Z" level=info msg="Docker daemon" commit=3ce5872b7950c63ba2ffbc5123101019ff3e6682 containerd-snapshotter=true storage-driver=overlayfs version=29.8.0 Oct 19 09:03:02.875027 dockerd[1953]: time="2026-10-19T09:03:02.874992126Z" level=info msg="Initializing buildkit" Oct 19 09:03:03.174512 sshd[1973]: Accepted publickey for core from 20.31.226.197 port 48538 ssh2: RSA SHA256:+zisaoRvPItXq46uUsficI82digkwc4vK8+kLWnkFMw Oct 19 09:03:03.179403 sshd-session[1973]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:03:03.198920 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 19 09:03:03.203992 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 19 09:03:03.264734 systemd-logind[1668]: New session '1' of user 'core' with class 'user' and type 'tty'. Oct 19 09:03:03.289110 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 19 09:03:03.295354 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 19 09:03:03.315610 (systemd)[2165]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:03:03.322488 systemd-logind[1668]: New session '2' of user 'core' with class 'manager-early' and type 'unspecified'. Oct 19 09:03:03.815028 systemd[2165]: Queued start job for default target default.target. Oct 19 09:03:03.821489 systemd[2165]: Created slice app.slice - User Application Slice. Oct 19 09:03:03.821579 systemd[2165]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Oct 19 09:03:03.821628 systemd[2165]: Reached target machines.target - Virtual Machines and Containers. Oct 19 09:03:03.821802 systemd[2165]: Reached target paths.target - Paths. Oct 19 09:03:03.821893 systemd[2165]: Reached target timers.target - Timers. Oct 19 09:03:03.827165 systemd[2165]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 19 09:03:03.836455 systemd[2165]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 19 09:03:03.836934 systemd[2165]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 19 09:03:03.841635 systemd[2165]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 19 09:03:03.842606 systemd[2165]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 19 09:03:03.846620 systemd[2165]: Listening on systemd-storage-fs.socket - Simple File System Backed Storage Provider. Oct 19 09:03:03.859162 systemd[2165]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Oct 19 09:03:03.869766 systemd[2165]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 19 09:03:03.871353 systemd[2165]: Reached target sockets.target - Sockets. Oct 19 09:03:03.889442 systemd[2165]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Oct 19 09:03:03.889754 systemd[2165]: Reached target basic.target - Basic System. Oct 19 09:03:03.891175 systemd[2165]: Reached target default.target - Main User Target. Oct 19 09:03:03.891256 systemd[2165]: Startup finished in 556ms. Oct 19 09:03:03.891397 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 19 09:03:03.898512 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 19 09:03:04.004131 dockerd[1953]: time="2026-10-19T09:03:04.004052371Z" level=info msg="Completed buildkit initialization" Oct 19 09:03:04.015223 dockerd[1953]: time="2026-10-19T09:03:04.015139337Z" level=info msg="Daemon has completed initialization" Oct 19 09:03:04.015352 dockerd[1953]: time="2026-10-19T09:03:04.015238635Z" level=info msg="API listen on /run/docker.sock" Oct 19 09:03:04.016184 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 19 09:03:04.021500 etcd-wrapper[1800]: Error response from daemon: No such container: etcd-member Oct 19 09:03:04.161705 etcd-wrapper[2198]: Unable to find image 'quay.io/coreos/etcd:v3.5.24' locally Oct 19 09:03:04.394465 systemd[1]: Started sshd@1-2-172.31.24.189:22-20.31.226.197:48552.service - OpenSSH per-connection server daemon (20.31.226.197:48552). Oct 19 09:03:04.637985 etcd-wrapper[2198]: v3.5.24: Pulling from coreos/etcd Oct 19 09:03:04.973391 etcd-wrapper[2198]: d10f96ed9607: Pulling fs layer Oct 19 09:03:04.974001 etcd-wrapper[2198]: d7c7ccc36d88: Pulling fs layer Oct 19 09:03:04.974001 etcd-wrapper[2198]: 2ae710cd8bfe: Pulling fs layer Oct 19 09:03:04.974001 etcd-wrapper[2198]: d462aa345367: Pulling fs layer Oct 19 09:03:04.975699 etcd-wrapper[2198]: 0f8b424aa0b9: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: d557676654e5: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: afae8b8aae79: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: c8022d07192e: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: d858cbc252ad: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: 1069fc2daed1: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: b40161cd83fc: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: 5318d93a3a65: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: 307c1adadb60: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: d28d4aa02c9a: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: 564a832d7b24: Pulling fs layer Oct 19 09:03:04.978228 etcd-wrapper[2198]: b5e058125d2e: Pulling fs layer Oct 19 09:03:05.225705 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1288437738.mount: Deactivated successfully. Oct 19 09:03:05.238818 sshd[2206]: Accepted publickey for core from 20.31.226.197 port 48552 ssh2: RSA SHA256:+zisaoRvPItXq46uUsficI82digkwc4vK8+kLWnkFMw Oct 19 09:03:05.241321 sshd-session[2206]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:03:05.253048 systemd-logind[1668]: New session '3' of user 'core' with class 'user' and type 'tty'. Oct 19 09:03:05.259430 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 19 09:03:05.278190 etcd-wrapper[2198]: d10f96ed9607: Download complete Oct 19 09:03:05.279784 etcd-wrapper[2198]: d7c7ccc36d88: Download complete Oct 19 09:03:05.281498 etcd-wrapper[2198]: 0f8b424aa0b9: Download complete Oct 19 09:03:05.282564 etcd-wrapper[2198]: d10f96ed9607: Pull complete Oct 19 09:03:05.377681 etcd-wrapper[2198]: 2ae710cd8bfe: Download complete Oct 19 09:03:05.377946 etcd-wrapper[2198]: d462aa345367: Download complete Oct 19 09:03:05.378449 etcd-wrapper[2198]: afae8b8aae79: Download complete Oct 19 09:03:05.381284 etcd-wrapper[2198]: 2ae710cd8bfe: Pull complete Oct 19 09:03:05.477403 etcd-wrapper[2198]: c8022d07192e: Download complete Oct 19 09:03:05.478431 etcd-wrapper[2198]: d858cbc252ad: Download complete Oct 19 09:03:05.479786 etcd-wrapper[2198]: d557676654e5: Download complete Oct 19 09:03:05.577884 etcd-wrapper[2198]: 1069fc2daed1: Download complete Oct 19 09:03:05.578952 etcd-wrapper[2198]: 5318d93a3a65: Download complete Oct 19 09:03:05.580520 etcd-wrapper[2198]: b40161cd83fc: Download complete Oct 19 09:03:05.675614 etcd-wrapper[2198]: 307c1adadb60: Download complete Oct 19 09:03:05.710429 sshd[2214]: Connection closed by 20.31.226.197 port 48552 Oct 19 09:03:05.711291 sshd-session[2206]: pam_unix(sshd:session): session closed for user core Oct 19 09:03:05.725774 systemd[1]: sshd@1-2-172.31.24.189:22-20.31.226.197:48552.service: Deactivated successfully. Oct 19 09:03:05.733823 systemd[1]: session-3.scope: Deactivated successfully. Oct 19 09:03:05.747397 systemd-logind[1668]: Session 3 logged out. Waiting for processes to exit. Oct 19 09:03:05.758444 systemd-logind[1668]: Removed session 3. Oct 19 09:03:05.885769 systemd[1]: Started sshd@2-4097-172.31.24.189:22-20.31.226.197:48564.service - OpenSSH per-connection server daemon (20.31.226.197:48564). Oct 19 09:03:06.076079 etcd-wrapper[2198]: d28d4aa02c9a: Download complete Oct 19 09:03:06.077280 etcd-wrapper[2198]: 564a832d7b24: Download complete Oct 19 09:03:06.078145 etcd-wrapper[2198]: b5e058125d2e: Download complete Oct 19 09:03:06.080051 etcd-wrapper[2198]: 0f8b424aa0b9: Pull complete Oct 19 09:03:06.081086 etcd-wrapper[2198]: d462aa345367: Pull complete Oct 19 09:03:06.084185 etcd-wrapper[2198]: d557676654e5: Pull complete Oct 19 09:03:06.177408 etcd-wrapper[2198]: c8022d07192e: Pull complete Oct 19 09:03:06.178300 etcd-wrapper[2198]: d858cbc252ad: Pull complete Oct 19 09:03:06.179783 etcd-wrapper[2198]: 1069fc2daed1: Pull complete Oct 19 09:03:06.181050 etcd-wrapper[2198]: b40161cd83fc: Pull complete Oct 19 09:03:06.280831 etcd-wrapper[2198]: 5318d93a3a65: Pull complete Oct 19 09:03:06.283716 etcd-wrapper[2198]: 307c1adadb60: Pull complete Oct 19 09:03:06.578941 etcd-wrapper[2198]: d28d4aa02c9a: Pull complete Oct 19 09:03:06.678199 etcd-wrapper[2198]: 564a832d7b24: Pull complete Oct 19 09:03:06.771955 sshd[2233]: Accepted publickey for core from 20.31.226.197 port 48564 ssh2: RSA SHA256:+zisaoRvPItXq46uUsficI82digkwc4vK8+kLWnkFMw Oct 19 09:03:06.774910 sshd-session[2233]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:03:06.789906 systemd-logind[1668]: New session '4' of user 'core' with class 'user' and type 'tty'. Oct 19 09:03:06.794311 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 19 09:03:06.878117 etcd-wrapper[2198]: afae8b8aae79: Pull complete Oct 19 09:03:06.878764 etcd-wrapper[2198]: b5e058125d2e: Pull complete Oct 19 09:03:06.909643 dockerd[1953]: time="2026-10-19T09:03:06.909575480Z" level=info msg="image pulled" digest="sha256:a193bdd3c1d1d11de961b6600231b2b3b4c4e092848dbb7d4c0e03b709ac7594" remote="quay.io/coreos/etcd:v3.5.24" Oct 19 09:03:06.932634 etcd-wrapper[2198]: d7c7ccc36d88: Pull complete Oct 19 09:03:06.932634 etcd-wrapper[2198]: Digest: sha256:a193bdd3c1d1d11de961b6600231b2b3b4c4e092848dbb7d4c0e03b709ac7594 Oct 19 09:03:06.932634 etcd-wrapper[2198]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.24 Oct 19 09:03:07.029951 systemd[1]: tmp-containerd\x2dmount1548918712.mount: Deactivated successfully. Oct 19 09:03:07.244559 sshd[2281]: Connection closed by 20.31.226.197 port 48564 Oct 19 09:03:07.246160 sshd-session[2233]: pam_unix(sshd:session): session closed for user core Oct 19 09:03:07.251604 containerd[1695]: time="2026-10-19T09:03:07.251335011Z" level=info msg="connecting to shim 4243fc2bc54e28d19afbb268d5e582826a8111e98dad45040cd8ac86767f83fa" address="unix:///run/containerd/s/2994fa94eab7c14dd980c431428178fab22628aaa1bb6e984f354c99d6e77eeb" namespace=moby protocol=ttrpc version=3 Oct 19 09:03:07.253898 systemd[1]: sshd@2-4097-172.31.24.189:22-20.31.226.197:48564.service: Deactivated successfully. Oct 19 09:03:07.260237 systemd[1]: session-4.scope: Deactivated successfully. Oct 19 09:03:07.267647 systemd-logind[1668]: Session 4 logged out. Waiting for processes to exit. Oct 19 09:03:07.274142 systemd-logind[1668]: Removed session 4. Oct 19 09:03:07.309488 systemd[1]: Started docker-4243fc2bc54e28d19afbb268d5e582826a8111e98dad45040cd8ac86767f83fa.scope - libcontainer container 4243fc2bc54e28d19afbb268d5e582826a8111e98dad45040cd8ac86767f83fa. Oct 19 09:03:07.392369 dockerd[1953]: time="2026-10-19T09:03:07.392087205Z" level=info msg="sbJoin: gwep4 ''->'', gwep6 ''->''" eid=e9f21c339f4c ep=etcd-member net=host nid=88cdb9388be4 Oct 19 09:03:07.442766 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.442204Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Oct 19 09:03:07.442766 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.442469Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec2f4b728800796b83ed417ad4977199"} Oct 19 09:03:07.442766 etcd-wrapper[2198]: {"level":"warn","ts":"2026-10-19T09:03:07.442521Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Oct 19 09:03:07.443946 etcd-wrapper[2198]: {"level":"warn","ts":"2026-10-19T09:03:07.442585Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.24"} Oct 19 09:03:07.443946 etcd-wrapper[2198]: {"level":"warn","ts":"2026-10-19T09:03:07.442636Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Oct 19 09:03:07.443946 etcd-wrapper[2198]: {"level":"warn","ts":"2026-10-19T09:03:07.442698Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Oct 19 09:03:07.443946 etcd-wrapper[2198]: {"level":"warn","ts":"2026-10-19T09:03:07.442839Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Oct 19 09:03:07.443946 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.442989Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://172.31.24.189:2379"]} Oct 19 09:03:07.443946 etcd-wrapper[2198]: {"level":"warn","ts":"2026-10-19T09:03:07.443247Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Oct 19 09:03:07.443946 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.443339Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Oct 19 09:03:07.449379 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.448401Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Oct 19 09:03:07.449379 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.448583Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.24","git-sha":"e72f3c2","go-version":"go1.24.9","go-os":"linux","go-arch":"arm64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"ec2f4b728800796b83ed417ad4977199","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://172.31.24.189:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec2f4b728800796b83ed417ad4977199=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} Oct 19 09:03:07.451712 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.451407Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.247796ms"} Oct 19 09:03:07.455934 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.455541Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Oct 19 09:03:07.456406 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.456153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Oct 19 09:03:07.456406 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.456214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Oct 19 09:03:07.456717 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.456539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Oct 19 09:03:07.456717 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.456573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Oct 19 09:03:07.457155 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.456923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Oct 19 09:03:07.460778 etcd-wrapper[2198]: {"level":"warn","ts":"2026-10-19T09:03:07.460500Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Oct 19 09:03:07.462552 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.462248Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} Oct 19 09:03:07.462552 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.462318Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} Oct 19 09:03:07.463912 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.463495Z","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"} Oct 19 09:03:07.467292 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.464916Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.24","cluster-version":"to_be_decided"} Oct 19 09:03:07.467292 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.465291Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Oct 19 09:03:07.467292 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.465781Z","caller":"etcdserver/server.go:759","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Oct 19 09:03:07.467292 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.465926Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Oct 19 09:03:07.467292 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.465990Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Oct 19 09:03:07.467292 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.466011Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Oct 19 09:03:07.467292 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.466265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Oct 19 09:03:07.467292 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.466354Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"],"added-peer-is-learner":false} Oct 19 09:03:07.468533 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.468232Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"127.0.0.1:2380"} Oct 19 09:03:07.468890 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.468679Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"127.0.0.1:2380"} Oct 19 09:03:07.469173 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:07.468250Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://172.31.24.189:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Oct 19 09:03:08.058310 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.057743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Oct 19 09:03:08.058310 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.057801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Oct 19 09:03:08.058310 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.057863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Oct 19 09:03:08.058310 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.057889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Oct 19 09:03:08.058310 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.057916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Oct 19 09:03:08.058310 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.057939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Oct 19 09:03:08.058310 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.057980Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Oct 19 09:03:08.059394 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.058897Z","caller":"etcdserver/server.go:2711","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Oct 19 09:03:08.059394 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.058928Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} Oct 19 09:03:08.060072 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.058904Z","caller":"etcdserver/server.go:2158","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:ec2f4b728800796b83ed417ad4977199 ClientURLs:[http://172.31.24.189:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Oct 19 09:03:08.060072 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.059645Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Oct 19 09:03:08.060072 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.059727Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Oct 19 09:03:08.060072 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.059760Z","caller":"etcdserver/server.go:2735","msg":"cluster version is updated","cluster-version":"3.5"} Oct 19 09:03:08.061076 systemd[1]: Started etcd-member.service - etcd (System Application Container). Oct 19 09:03:08.062422 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.060148Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Oct 19 09:03:08.062422 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.060349Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Oct 19 09:03:08.062422 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.060615Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Oct 19 09:03:08.062548 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 19 09:03:08.063205 systemd[1]: Startup finished in 3.628s (kernel) + 11.954s (initrd) + 25.026s (userspace) = 40.609s. Oct 19 09:03:08.063833 etcd-wrapper[2198]: {"level":"info","ts":"2026-10-19T09:03:08.062980Z","caller":"embed/serve.go:210","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Oct 19 09:03:17.408087 systemd[1]: Started sshd@3-4098-172.31.24.189:22-20.31.226.197:37140.service - OpenSSH per-connection server daemon (20.31.226.197:37140). Oct 19 09:03:18.248863 sshd[2353]: Accepted publickey for core from 20.31.226.197 port 37140 ssh2: RSA SHA256:+zisaoRvPItXq46uUsficI82digkwc4vK8+kLWnkFMw Oct 19 09:03:18.251496 sshd-session[2353]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:03:18.262081 systemd-logind[1668]: New session '5' of user 'core' with class 'user' and type 'tty'. Oct 19 09:03:18.266260 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 19 09:03:18.720296 sshd[2357]: Connection closed by 20.31.226.197 port 37140 Oct 19 09:03:18.721264 sshd-session[2353]: pam_unix(sshd:session): session closed for user core Oct 19 09:03:18.726843 systemd[1]: sshd@3-4098-172.31.24.189:22-20.31.226.197:37140.service: Deactivated successfully. Oct 19 09:03:18.731652 systemd[1]: session-5.scope: Deactivated successfully. Oct 19 09:03:18.736869 systemd-logind[1668]: Session 5 logged out. Waiting for processes to exit. Oct 19 09:03:18.741111 systemd-logind[1668]: Removed session 5. Oct 19 09:03:18.890098 systemd[1]: Started sshd@4-4099-172.31.24.189:22-20.31.226.197:37148.service - OpenSSH per-connection server daemon (20.31.226.197:37148). Oct 19 09:03:19.730299 sshd[2363]: Accepted publickey for core from 20.31.226.197 port 37148 ssh2: RSA SHA256:+zisaoRvPItXq46uUsficI82digkwc4vK8+kLWnkFMw Oct 19 09:03:19.733135 sshd-session[2363]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:03:19.743058 systemd-logind[1668]: New session '6' of user 'core' with class 'user' and type 'tty'. Oct 19 09:03:19.746361 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 19 09:03:20.196255 sshd[2367]: Connection closed by 20.31.226.197 port 37148 Oct 19 09:03:20.198356 sshd-session[2363]: pam_unix(sshd:session): session closed for user core Oct 19 09:03:20.203815 systemd[1]: sshd@4-4099-172.31.24.189:22-20.31.226.197:37148.service: Deactivated successfully. Oct 19 09:03:20.208883 systemd[1]: session-6.scope: Deactivated successfully. Oct 19 09:03:20.213913 systemd-logind[1668]: Session 6 logged out. Waiting for processes to exit. Oct 19 09:03:20.218121 systemd-logind[1668]: Removed session 6. Oct 19 09:03:20.366442 systemd[1]: Started sshd@5-4100-172.31.24.189:22-20.31.226.197:38116.service - OpenSSH per-connection server daemon (20.31.226.197:38116). Oct 19 09:03:21.207245 sshd[2373]: Accepted publickey for core from 20.31.226.197 port 38116 ssh2: RSA SHA256:+zisaoRvPItXq46uUsficI82digkwc4vK8+kLWnkFMw Oct 19 09:03:21.209225 sshd-session[2373]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:03:21.220052 systemd-logind[1668]: New session '7' of user 'core' with class 'user' and type 'tty'. Oct 19 09:03:21.221290 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 19 09:03:21.677918 sshd[2377]: Connection closed by 20.31.226.197 port 38116 Oct 19 09:03:21.678888 sshd-session[2373]: pam_unix(sshd:session): session closed for user core Oct 19 09:03:21.684520 systemd[1]: sshd@5-4100-172.31.24.189:22-20.31.226.197:38116.service: Deactivated successfully. Oct 19 09:03:21.689719 systemd[1]: session-7.scope: Deactivated successfully. Oct 19 09:03:21.694070 systemd-logind[1668]: Session 7 logged out. Waiting for processes to exit. Oct 19 09:03:21.699377 systemd-logind[1668]: Removed session 7. Oct 19 09:03:21.846294 systemd[1]: Started sshd@6-4101-172.31.24.189:22-20.31.226.197:38120.service - OpenSSH per-connection server daemon (20.31.226.197:38120). Oct 19 09:03:22.689625 sshd[2383]: Accepted publickey for core from 20.31.226.197 port 38120 ssh2: RSA SHA256:+zisaoRvPItXq46uUsficI82digkwc4vK8+kLWnkFMw Oct 19 09:03:22.692426 sshd-session[2383]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:03:22.703053 systemd-logind[1668]: New session '8' of user 'core' with class 'user' and type 'tty'. Oct 19 09:03:22.704355 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 19 09:03:23.157205 sshd[2387]: Connection closed by 20.31.226.197 port 38120 Oct 19 09:03:23.158217 sshd-session[2383]: pam_unix(sshd:session): session closed for user core Oct 19 09:03:23.165634 systemd[1]: sshd@6-4101-172.31.24.189:22-20.31.226.197:38120.service: Deactivated successfully. Oct 19 09:03:23.170129 systemd[1]: session-8.scope: Deactivated successfully. Oct 19 09:03:23.174576 systemd-logind[1668]: Session 8 logged out. Waiting for processes to exit. Oct 19 09:03:23.179315 systemd-logind[1668]: Removed session 8. Oct 19 09:03:23.327421 systemd[1]: Started sshd@7-3-172.31.24.189:22-20.31.226.197:38130.service - OpenSSH per-connection server daemon (20.31.226.197:38130). Oct 19 09:03:24.168812 sshd[2393]: Accepted publickey for core from 20.31.226.197 port 38130 ssh2: RSA SHA256:+zisaoRvPItXq46uUsficI82digkwc4vK8+kLWnkFMw Oct 19 09:03:24.171592 sshd-session[2393]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 09:03:24.182114 systemd-logind[1668]: New session '9' of user 'core' with class 'user' and type 'tty'. Oct 19 09:03:24.187391 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 19 09:03:25.086596 sshd[2397]: Connection closed by 20.31.226.197 port 38130 Oct 19 09:03:25.088264 sshd-session[2393]: pam_unix(sshd:session): session closed for user core Oct 19 09:03:25.094056 systemd[1]: sshd@7-3-172.31.24.189:22-20.31.226.197:38130.service: Deactivated successfully. Oct 19 09:03:25.098385 systemd[1]: session-9.scope: Deactivated successfully. Oct 19 09:03:25.103156 systemd-logind[1668]: Session 9 logged out. Waiting for processes to exit. Oct 19 09:03:25.107338 systemd-logind[1668]: Removed session 9. Oct 19 09:03:28.078274 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Oct 19 09:03:41.457647 update_engine[1672]: I20261019 09:03:41.457548 1672 update_attempter.cc:509] Updating boot flags... Oct 19 09:06:33.536307 update_engine[1672]: I20261019 09:06:33.536237 1672 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs Oct 19 09:06:33.537148 update_engine[1672]: I20261019 09:06:33.536309 1672 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs Oct 19 09:06:33.537148 update_engine[1672]: I20261019 09:06:33.536617 1672 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs Oct 19 09:06:33.537463 update_engine[1672]: I20261019 09:06:33.537416 1672 omaha_request_params.cc:62] Current group set to developer Oct 19 09:06:33.540269 update_engine[1672]: I20261019 09:06:33.537573 1672 update_attempter.cc:499] Already updated boot flags. Skipping. Oct 19 09:06:33.540269 update_engine[1672]: I20261019 09:06:33.538813 1672 update_attempter.cc:643] Scheduling an action processor start. Oct 19 09:06:33.540269 update_engine[1672]: I20261019 09:06:33.538880 1672 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 19 09:06:33.540269 update_engine[1672]: I20261019 09:06:33.539304 1672 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs Oct 19 09:06:33.540269 update_engine[1672]: I20261019 09:06:33.539431 1672 omaha_request_action.cc:271] Posting an Omaha request to disabled Oct 19 09:06:33.540269 update_engine[1672]: I20261019 09:06:33.539451 1672 omaha_request_action.cc:272] Request: Oct 19 09:06:33.540269 update_engine[1672]: Oct 19 09:06:33.540269 update_engine[1672]: Oct 19 09:06:33.540269 update_engine[1672]: Oct 19 09:06:33.540269 update_engine[1672]: Oct 19 09:06:33.540269 update_engine[1672]: Oct 19 09:06:33.540269 update_engine[1672]: Oct 19 09:06:33.540269 update_engine[1672]: Oct 19 09:06:33.540269 update_engine[1672]: Oct 19 09:06:33.540269 update_engine[1672]: I20261019 09:06:33.539467 1672 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Oct 19 09:06:33.541107 locksmithd[1727]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0 Oct 19 09:06:33.543568 update_engine[1672]: I20261019 09:06:33.543497 1672 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Oct 19 09:06:33.544727 update_engine[1672]: I20261019 09:06:33.544660 1672 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Oct 19 09:06:33.547095 update_engine[1672]: E20261019 09:06:33.547037 1672 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (Domain name not found) Oct 19 09:06:33.547191 update_engine[1672]: I20261019 09:06:33.547122 1672 libcurl_http_fetcher.cc:283] No HTTP response, retry 1 Oct 19 09:06:43.464064 update_engine[1672]: I20261019 09:06:43.463927 1672 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Oct 19 09:06:43.464712 update_engine[1672]: I20261019 09:06:43.464113 1672 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Oct 19 09:06:43.464712 update_engine[1672]: I20261019 09:06:43.464596 1672 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Oct 19 09:06:43.466144 update_engine[1672]: E20261019 09:06:43.466085 1672 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (Domain name not found) Oct 19 09:06:43.466226 update_engine[1672]: I20261019 09:06:43.466157 1672 libcurl_http_fetcher.cc:283] No HTTP response, retry 2