Oct 19 14:29:30.824577 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Oct 19 14:29:30.824633 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 12:14:34 -00 2026 Oct 19 14:29:30.824654 kernel: KASLR disabled due to lack of seed Oct 19 14:29:30.824670 kernel: efi: EFI v2.7 by EDK II Oct 19 14:29:30.824686 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7a5f1a98 MEMRESERVE=0x78551b98 Oct 19 14:29:30.824707 kernel: secureboot: Secure boot disabled Oct 19 14:29:30.824777 kernel: ACPI: Early table checksum verification disabled Oct 19 14:29:30.824839 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Oct 19 14:29:30.824877 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Oct 19 14:29:30.824894 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Oct 19 14:29:30.824910 kernel: ACPI: DSDT 0x0000000078640000 0013D2 (v02 AMAZON AMZNDSDT 00000001 AMZN 00000001) Oct 19 14:29:30.824925 kernel: ACPI: FACS 0x0000000078630000 000040 Oct 19 14:29:30.824960 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Oct 19 14:29:30.825028 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Oct 19 14:29:30.825048 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Oct 19 14:29:30.825065 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Oct 19 14:29:30.825082 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Oct 19 14:29:30.825104 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Oct 19 14:29:30.825120 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Oct 19 14:29:30.825136 kernel: ACPI: SPCR: console: uart,mmio,0x80000000,115200 Oct 19 14:29:30.825153 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Oct 19 14:29:30.825169 kernel: NODE_DATA(0) allocated [mem 0x4b584fa00-0x4b5856fff] Oct 19 14:29:30.825184 kernel: Zone ranges: Oct 19 14:29:30.825200 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Oct 19 14:29:30.825216 kernel: DMA32 empty Oct 19 14:29:30.825232 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Oct 19 14:29:30.825248 kernel: Device empty Oct 19 14:29:30.825264 kernel: Movable zone start for each node Oct 19 14:29:30.825284 kernel: Early memory node ranges Oct 19 14:29:30.825300 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Oct 19 14:29:30.825316 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Oct 19 14:29:30.825332 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Oct 19 14:29:30.825348 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Oct 19 14:29:30.825380 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Oct 19 14:29:30.825398 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Oct 19 14:29:30.825415 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Oct 19 14:29:30.825431 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Oct 19 14:29:30.825448 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Oct 19 14:29:30.825465 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Oct 19 14:29:30.825482 kernel: cma: Reserved 16 MiB at 0x000000007f000000 Oct 19 14:29:30.825512 kernel: psci: probing for conduit method from ACPI. Oct 19 14:29:30.825529 kernel: psci: PSCIv1.0 detected in firmware. Oct 19 14:29:30.825547 kernel: psci: Using standard PSCI v0.2 function IDs Oct 19 14:29:30.825568 kernel: psci: Trusted OS migration not required Oct 19 14:29:30.825585 kernel: psci: SMC Calling Convention v1.1 Oct 19 14:29:30.825602 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Oct 19 14:29:30.825619 kernel: percpu: Embedded 34 pages/cpu s99608 r8192 d31464 u139264 Oct 19 14:29:30.825636 kernel: pcpu-alloc: s99608 r8192 d31464 u139264 alloc=34*4096 Oct 19 14:29:30.825653 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 19 14:29:30.825670 kernel: Detected PIPT I-cache on CPU0 Oct 19 14:29:30.825687 kernel: CPU features: detected: GICv3 CPU interface Oct 19 14:29:30.825704 kernel: CPU features: detected: Spectre-v2 Oct 19 14:29:30.825721 kernel: CPU features: detected: Spectre-v3a Oct 19 14:29:30.825737 kernel: CPU features: detected: Spectre-BHB Oct 19 14:29:30.825759 kernel: CPU features: detected: ARM erratum 1742098 Oct 19 14:29:30.825776 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Oct 19 14:29:30.825792 kernel: alternatives: applying boot alternatives Oct 19 14:29:30.825811 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=d88eec92645b2922a7afec0deee119d005dd43b526057d21bd6466ee9a4ad3b2 Oct 19 14:29:30.825829 kernel: printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes Oct 19 14:29:30.825846 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 19 14:29:30.825863 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 19 14:29:30.825879 kernel: software IO TLB: area num 2. Oct 19 14:29:30.825896 kernel: software IO TLB: mapped [mem 0x0000000074530000-0x0000000078530000] (64MB) Oct 19 14:29:30.825917 kernel: Fallback order for Node 0: 0 Oct 19 14:29:30.825935 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1007616 Oct 19 14:29:30.825976 kernel: Policy zone: Normal Oct 19 14:29:30.825995 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 19 14:29:30.826013 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 19 14:29:30.826029 kernel: ftrace: allocating 43121 entries in 170 pages Oct 19 14:29:30.826046 kernel: ftrace: allocated 170 pages with 4 groups Oct 19 14:29:30.826063 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 19 14:29:30.826081 kernel: rcu: RCU event tracing is enabled. Oct 19 14:29:30.826099 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 19 14:29:30.826116 kernel: Trampoline variant of Tasks RCU enabled. Oct 19 14:29:30.826133 kernel: Rude variant of Tasks RCU enabled. Oct 19 14:29:30.826156 kernel: Tracing variant of Tasks RCU enabled. Oct 19 14:29:30.826173 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 19 14:29:30.826190 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 19 14:29:30.826207 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 19 14:29:30.826224 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 19 14:29:30.826241 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 19 14:29:30.826257 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 19 14:29:30.826274 kernel: GICv3: 96 SPIs implemented Oct 19 14:29:30.826291 kernel: GICv3: 0 Extended SPIs implemented Oct 19 14:29:30.826307 kernel: Root IRQ handler: gic_handle_irq Oct 19 14:29:30.826324 kernel: GICv3: GICv3 features: 16 PPIs Oct 19 14:29:30.826345 kernel: GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 Oct 19 14:29:30.826362 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Oct 19 14:29:30.826379 kernel: ITS [mem 0x10080000-0x1009ffff] Oct 19 14:29:30.826396 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4001a0000 (indirect, esz 8, psz 64K, shr 1) Oct 19 14:29:30.826414 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4001b0000 (flat, esz 8, psz 64K, shr 1) Oct 19 14:29:30.826430 kernel: GICv3: using LPI property table @0x00000004001c0000 Oct 19 14:29:30.826447 kernel: ITS: Using hypervisor restricted LPI range [128] Oct 19 14:29:30.826464 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004001d0000 Oct 19 14:29:30.826481 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 19 14:29:30.826498 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 19 14:29:30.826515 kernel: arch_timer: cp15 timer running at 83.33MHz (virt). Oct 19 14:29:30.826536 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Oct 19 14:29:30.826553 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Oct 19 14:29:30.826570 kernel: Console: colour dummy device 80x25 Oct 19 14:29:30.826588 kernel: printk: legacy console [tty1] enabled Oct 19 14:29:30.826605 kernel: ACPI: Core revision 20250807 Oct 19 14:29:30.826623 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Oct 19 14:29:30.826641 kernel: pid_max: default: 32768 minimum: 301 Oct 19 14:29:30.826658 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 19 14:29:30.826680 kernel: landlock: Up and running. Oct 19 14:29:30.826698 kernel: SELinux: Initializing. Oct 19 14:29:30.826715 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 19 14:29:30.826733 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 19 14:29:30.826750 kernel: rcu: Hierarchical SRCU implementation. Oct 19 14:29:30.826768 kernel: rcu: Max phase no-delay instances is 400. Oct 19 14:29:30.826785 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 19 14:29:30.826807 kernel: Remapping and enabling EFI services. Oct 19 14:29:30.826824 kernel: smp: Bringing up secondary CPUs ... Oct 19 14:29:30.826841 kernel: Detected PIPT I-cache on CPU1 Oct 19 14:29:30.826859 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Oct 19 14:29:30.826876 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004001e0000 Oct 19 14:29:30.826894 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Oct 19 14:29:30.826924 kernel: smp: Brought up 1 node, 2 CPUs Oct 19 14:29:30.826957 kernel: SMP: Total of 2 processors activated. Oct 19 14:29:30.826982 kernel: CPU: All CPU(s) started at EL1 Oct 19 14:29:30.827000 kernel: CPU features: detected: 32-bit EL0 Support Oct 19 14:29:30.827024 kernel: CPU features: detected: 32-bit EL1 Support Oct 19 14:29:30.827043 kernel: CPU features: detected: CRC32 instructions Oct 19 14:29:30.827061 kernel: CPU features: detected: PMUv3 Oct 19 14:29:30.827083 kernel: alternatives: applying system-wide alternatives Oct 19 14:29:30.827102 kernel: Memory: 3818496K/4030464K available (13248K kernel code, 2506K rwdata, 9996K rodata, 13568K init, 984K bss, 189812K reserved, 16384K cma-reserved) Oct 19 14:29:30.827121 kernel: devtmpfs: initialized Oct 19 14:29:30.827139 kernel: posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) Oct 19 14:29:30.827157 kernel: futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). Oct 19 14:29:30.827176 kernel: 22624 pages in range for non-PLT usage Oct 19 14:29:30.827193 kernel: 514144 pages in range for PLT usage Oct 19 14:29:30.827216 kernel: pinctrl core: initialized pinctrl subsystem Oct 19 14:29:30.827234 kernel: SMBIOS 3.0.0 present. Oct 19 14:29:30.827252 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Oct 19 14:29:30.827270 kernel: DMI: Memory slots populated: 0/0 Oct 19 14:29:30.827288 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 19 14:29:30.827306 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 19 14:29:30.827325 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 19 14:29:30.827383 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 19 14:29:30.827415 kernel: audit: initializing netlink subsys (disabled) Oct 19 14:29:30.827434 kernel: audit: type=2000 audit(0.225:1): state=initialized audit_enabled=0 res=1 Oct 19 14:29:30.827453 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 19 14:29:30.827471 kernel: cpuidle: using governor menu Oct 19 14:29:30.827491 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 19 14:29:30.827510 kernel: ASID allocator initialised with 65536 entries Oct 19 14:29:30.827530 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 19 14:29:30.827552 kernel: Serial: AMBA PL011 UART driver Oct 19 14:29:30.827571 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 19 14:29:30.827590 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 19 14:29:30.827608 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 19 14:29:30.827626 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 19 14:29:30.827645 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 19 14:29:30.827664 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 19 14:29:30.827687 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 19 14:29:30.827705 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 19 14:29:30.827724 kernel: ACPI: Added _OSI(Module Device) Oct 19 14:29:30.827742 kernel: ACPI: Added _OSI(Processor Device) Oct 19 14:29:30.827760 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 19 14:29:30.827779 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 19 14:29:30.827798 kernel: ACPI: Interpreter enabled Oct 19 14:29:30.827821 kernel: ACPI: Using GIC for interrupt routing Oct 19 14:29:30.827840 kernel: ACPI: MCFG table detected, 1 entries Oct 19 14:29:30.827858 kernel: ACPI: CPU0 has been hot-added Oct 19 14:29:30.827879 kernel: ACPI: CPU1 has been hot-added Oct 19 14:29:30.827897 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00]) Oct 19 14:29:30.843303 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 19 14:29:30.843697 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 19 14:29:30.844078 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 19 14:29:30.844425 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x200fffff] reserved by PNP0C02:00 Oct 19 14:29:30.844791 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x200fffff] for [bus 00] Oct 19 14:29:30.844831 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Oct 19 14:29:30.844876 kernel: acpiphp: Slot [1] registered Oct 19 14:29:30.844899 kernel: acpiphp: Slot [2] registered Oct 19 14:29:30.844933 kernel: acpiphp: Slot [3] registered Oct 19 14:29:30.849714 kernel: acpiphp: Slot [4] registered Oct 19 14:29:30.849759 kernel: acpiphp: Slot [5] registered Oct 19 14:29:30.849780 kernel: acpiphp: Slot [6] registered Oct 19 14:29:30.849814 kernel: acpiphp: Slot [7] registered Oct 19 14:29:30.849833 kernel: acpiphp: Slot [8] registered Oct 19 14:29:30.849867 kernel: acpiphp: Slot [9] registered Oct 19 14:29:30.849915 kernel: acpiphp: Slot [10] registered Oct 19 14:29:30.849963 kernel: acpiphp: Slot [11] registered Oct 19 14:29:30.849999 kernel: acpiphp: Slot [12] registered Oct 19 14:29:30.850019 kernel: acpiphp: Slot [13] registered Oct 19 14:29:30.850053 kernel: acpiphp: Slot [14] registered Oct 19 14:29:30.850084 kernel: acpiphp: Slot [15] registered Oct 19 14:29:30.850106 kernel: acpiphp: Slot [16] registered Oct 19 14:29:30.850139 kernel: acpiphp: Slot [17] registered Oct 19 14:29:30.850168 kernel: acpiphp: Slot [18] registered Oct 19 14:29:30.850203 kernel: acpiphp: Slot [19] registered Oct 19 14:29:30.850239 kernel: acpiphp: Slot [20] registered Oct 19 14:29:30.850276 kernel: acpiphp: Slot [21] registered Oct 19 14:29:30.850313 kernel: acpiphp: Slot [22] registered Oct 19 14:29:30.850349 kernel: acpiphp: Slot [23] registered Oct 19 14:29:30.850386 kernel: acpiphp: Slot [24] registered Oct 19 14:29:30.850429 kernel: acpiphp: Slot [25] registered Oct 19 14:29:30.850466 kernel: acpiphp: Slot [26] registered Oct 19 14:29:30.850498 kernel: acpiphp: Slot [27] registered Oct 19 14:29:30.850517 kernel: acpiphp: Slot [28] registered Oct 19 14:29:30.850553 kernel: acpiphp: Slot [29] registered Oct 19 14:29:30.850589 kernel: acpiphp: Slot [30] registered Oct 19 14:29:30.850619 kernel: acpiphp: Slot [31] registered Oct 19 14:29:30.850662 kernel: PCI host bridge to bus 0000:00 Oct 19 14:29:30.851605 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Oct 19 14:29:30.852394 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 19 14:29:30.853008 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Oct 19 14:29:30.853582 kernel: pci_bus 0000:00: root bus resource [bus 00] Oct 19 14:29:30.854018 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 conventional PCI endpoint Oct 19 14:29:30.860207 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 conventional PCI endpoint Oct 19 14:29:30.860559 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff] Oct 19 14:29:30.861097 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 PCIe Root Complex Integrated Endpoint Oct 19 14:29:30.861663 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80114000-0x80117fff] Oct 19 14:29:30.862409 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 19 14:29:30.863158 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 PCIe Root Complex Integrated Endpoint Oct 19 14:29:30.863524 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80110000-0x80113fff] Oct 19 14:29:30.863852 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref] Oct 19 14:29:30.864330 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff] Oct 19 14:29:30.864925 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 19 14:29:30.865473 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Oct 19 14:29:30.866189 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 19 14:29:30.866827 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Oct 19 14:29:30.866878 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 19 14:29:30.866921 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 19 14:29:30.867024 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 19 14:29:30.867064 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 19 14:29:30.867099 kernel: iommu: Default domain type: Translated Oct 19 14:29:30.867155 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 19 14:29:30.867193 kernel: efivars: Registered efivars operations Oct 19 14:29:30.867223 kernel: vgaarb: loaded Oct 19 14:29:30.867244 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 19 14:29:30.867280 kernel: VFS: Disk quotas dquot_6.6.0 Oct 19 14:29:30.867321 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 19 14:29:30.867358 kernel: pnp: PnP ACPI init Oct 19 14:29:30.867915 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Oct 19 14:29:30.867994 kernel: pnp: PnP ACPI: found 1 devices Oct 19 14:29:30.868017 kernel: NET: Registered PF_INET protocol family Oct 19 14:29:30.868037 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 19 14:29:30.868057 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 19 14:29:30.868077 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 19 14:29:30.868110 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 19 14:29:30.868130 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 19 14:29:30.868149 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 19 14:29:30.868169 kernel: UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) Oct 19 14:29:30.868188 kernel: UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) Oct 19 14:29:30.868207 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 19 14:29:30.868226 kernel: PCI: CLS 0 bytes, default 64 Oct 19 14:29:30.868253 kernel: kvm [1]: HYP mode not available Oct 19 14:29:30.868274 kernel: Initialise system trusted keyrings Oct 19 14:29:30.868293 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 19 14:29:30.868312 kernel: Key type asymmetric registered Oct 19 14:29:30.868332 kernel: Asymmetric key parser 'x509' registered Oct 19 14:29:30.868351 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) Oct 19 14:29:30.868371 kernel: io scheduler mq-deadline registered Oct 19 14:29:30.868396 kernel: io scheduler kyber registered Oct 19 14:29:30.868417 kernel: io scheduler bfq registered Oct 19 14:29:30.868895 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Oct 19 14:29:30.869051 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 19 14:29:30.869097 kernel: ACPI: button: Power Button [PWRB] Oct 19 14:29:30.869147 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Oct 19 14:29:30.869189 kernel: ACPI: button: Sleep Button [SLPB] Oct 19 14:29:30.869247 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 19 14:29:30.869290 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Oct 19 14:29:30.870055 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Oct 19 14:29:30.870119 kernel: printk: legacy console [ttyS0] disabled Oct 19 14:29:30.870143 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Oct 19 14:29:30.870175 kernel: printk: legacy console [ttyS0] enabled Oct 19 14:29:30.870215 kernel: ACPI: bus type drm_connector registered Oct 19 14:29:30.870271 kernel: thunder_xcv, ver 1.0 Oct 19 14:29:30.870321 kernel: thunder_bgx, ver 1.0 Oct 19 14:29:30.870377 kernel: nicpf, ver 1.0 Oct 19 14:29:30.870423 kernel: nicvf, ver 1.0 Oct 19 14:29:30.871371 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 19 14:29:30.877756 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-10-19T14:29:25 UTC (1792420165) Oct 19 14:29:30.877820 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 19 14:29:30.877854 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 (0,80000003) counters available Oct 19 14:29:30.877873 kernel: watchdog: NMI not fully supported Oct 19 14:29:30.877892 kernel: NET: Registered PF_INET6 protocol family Oct 19 14:29:30.877911 kernel: watchdog: Hard watchdog permanently disabled Oct 19 14:29:30.877930 kernel: Segment Routing with IPv6 Oct 19 14:29:30.877986 kernel: In-situ OAM (IOAM) with IPv6 Oct 19 14:29:30.878008 kernel: NET: Registered PF_PACKET protocol family Oct 19 14:29:30.878036 kernel: Key type dns_resolver registered Oct 19 14:29:30.878057 kernel: registered taskstats version 1 Oct 19 14:29:30.878077 kernel: Loading compiled-in X.509 certificates Oct 19 14:29:30.878096 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.18.45-flatcar: 6b8731284561f98272147e0eb619b01fbebb8bc6' Oct 19 14:29:30.878114 kernel: Demotion targets for Node 0: null Oct 19 14:29:30.878147 kernel: Key type .fscrypt registered Oct 19 14:29:30.878172 kernel: Key type fscrypt-provisioning registered Oct 19 14:29:30.878198 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 19 14:29:30.878218 kernel: ima: Allocated hash algorithm: sha1 Oct 19 14:29:30.878236 kernel: ima: No architecture policies found Oct 19 14:29:30.878255 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 19 14:29:30.878274 kernel: clk: Disabling unused clocks Oct 19 14:29:30.878293 kernel: PM: genpd: Disabling unused power domains Oct 19 14:29:30.878311 kernel: Freeing unused kernel memory: 13568K Oct 19 14:29:30.878334 kernel: Run /init as init process Oct 19 14:29:30.878354 kernel: with arguments: Oct 19 14:29:30.878374 kernel: /init Oct 19 14:29:30.878392 kernel: with environment: Oct 19 14:29:30.878411 kernel: HOME=/ Oct 19 14:29:30.878430 kernel: TERM=linux Oct 19 14:29:30.878450 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Oct 19 14:29:30.878873 kernel: nvme nvme0: pci function 0000:00:04.0 Oct 19 14:29:30.879673 kernel: nvme nvme0: 2/0/0 default/read/poll queues Oct 19 14:29:30.879783 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 19 14:29:30.879846 kernel: GPT:25804799 != 33554431 Oct 19 14:29:30.879908 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 19 14:29:30.880008 kernel: GPT:25804799 != 33554431 Oct 19 14:29:30.880056 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 19 14:29:30.880140 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 19 14:29:30.880202 kernel: SCSI subsystem initialized Oct 19 14:29:30.880264 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 19 14:29:30.880323 kernel: device-mapper: uevent: version 1.0.3 Oct 19 14:29:30.880375 kernel: device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev Oct 19 14:29:30.880434 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:30.880481 kernel: raid6: neonx8 gen() 6531 MB/s Oct 19 14:29:30.880543 kernel: raid6: neonx4 gen() 6471 MB/s Oct 19 14:29:30.880605 kernel: raid6: neonx2 gen() 5478 MB/s Oct 19 14:29:30.880667 kernel: raid6: neonx1 gen() 3950 MB/s Oct 19 14:29:30.880723 kernel: raid6: int64x8 gen() 3175 MB/s Oct 19 14:29:30.880777 kernel: raid6: int64x4 gen() 3670 MB/s Oct 19 14:29:30.880822 kernel: raid6: int64x2 gen() 3610 MB/s Oct 19 14:29:30.880872 kernel: raid6: int64x1 gen() 2679 MB/s Oct 19 14:29:30.881050 kernel: raid6: using algorithm neonx8 gen() 6531 MB/s Oct 19 14:29:30.881116 kernel: raid6: .... xor() 4510 MB/s, rmw enabled Oct 19 14:29:30.881154 kernel: raid6: using neon recovery algorithm Oct 19 14:29:30.881213 kernel: xor: measuring software checksum speed Oct 19 14:29:30.881275 kernel: 8regs : 10368 MB/sec Oct 19 14:29:30.881339 kernel: 32regs : 11032 MB/sec Oct 19 14:29:30.881403 kernel: arm64_neon : 9158 MB/sec Oct 19 14:29:30.881473 kernel: xor: using function: 32regs (11032 MB/sec) Oct 19 14:29:30.881517 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 19 14:29:30.881541 kernel: BTRFS: device fsid 8988790c-4e6b-4655-b458-9ef35bbe287e devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (208) Oct 19 14:29:30.881574 kernel: BTRFS info (device dm-0): first mount of filesystem 8988790c-4e6b-4655-b458-9ef35bbe287e Oct 19 14:29:30.881617 kernel: BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm Oct 19 14:29:30.881660 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Oct 19 14:29:30.881704 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Oct 19 14:29:30.881754 kernel: BTRFS info (device dm-0 state E): enabling free space tree Oct 19 14:29:30.881786 kernel: loop: module loaded Oct 19 14:29:30.881805 kernel: loop0: detected capacity change from 0 to 102080 Oct 19 14:29:30.881824 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 19 14:29:30.881846 systemd[1]: Successfully made /usr/ read-only. Oct 19 14:29:30.881872 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 14:29:30.881907 systemd[1]: Detected virtualization amazon. Oct 19 14:29:30.881928 systemd[1]: Detected architecture arm64. Oct 19 14:29:30.881995 systemd[1]: Running in initrd. Oct 19 14:29:30.882019 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 19 14:29:30.882041 systemd[1]: No hostname configured, using default hostname. Oct 19 14:29:30.882062 systemd[1]: Hostname set to . Oct 19 14:29:30.882083 systemd[1]: Queued start job for default target initrd.target. Oct 19 14:29:30.882115 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 19 14:29:30.882154 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 19 14:29:30.882184 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 19 14:29:30.882206 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 19 14:29:30.882232 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 19 14:29:30.882257 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 19 14:29:30.882279 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 19 14:29:30.882300 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 19 14:29:30.882322 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 19 14:29:30.882344 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 19 14:29:30.882371 systemd[1]: Reached target paths.target - Path Units. Oct 19 14:29:30.882392 systemd[1]: Reached target slices.target - Slice Units. Oct 19 14:29:30.882414 systemd[1]: Reached target swap.target - Swaps. Oct 19 14:29:30.882436 systemd[1]: Reached target timers.target - Timer Units. Oct 19 14:29:30.882459 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 19 14:29:30.882481 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 19 14:29:30.882502 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 19 14:29:30.882529 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 19 14:29:30.882552 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 19 14:29:30.882572 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 19 14:29:30.882594 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 19 14:29:30.882616 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 19 14:29:30.882637 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 19 14:29:30.882659 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 19 14:29:30.882685 systemd[1]: Reached target sockets.target - Socket Units. Oct 19 14:29:30.882709 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 19 14:29:30.882730 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 19 14:29:30.882752 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 19 14:29:30.882774 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 19 14:29:30.882803 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Oct 19 14:29:30.882824 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 19 14:29:30.882847 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 19 14:29:30.882875 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 19 14:29:30.882897 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 14:29:30.882918 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 19 14:29:30.882939 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 19 14:29:30.883037 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 19 14:29:30.883063 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 19 14:29:30.883092 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 19 14:29:30.883114 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 19 14:29:30.883135 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 14:29:30.883250 systemd-journald[331]: Collecting audit messages is enabled. Oct 19 14:29:30.883307 kernel: Bridge firewalling registered Oct 19 14:29:30.883346 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 19 14:29:30.883374 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 19 14:29:30.883396 kernel: audit: type=1130 audit(1792420170.826: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 14:29:30.883431 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 19 14:29:30.883470 kernel: audit: type=1130 audit(1792420170.831:3): 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 14:29:30.883510 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 19 14:29:30.883556 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 14:29:30.883597 systemd-journald[331]: Journal started Oct 19 14:29:30.883664 systemd-journald[331]: Runtime Journal (/run/log/journal/ec21228f063f266b5d4f8ec869c54358) is 8M, max 75.2M, 67.2M free. Oct 19 14:29:30.826000 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 14:29:30.831000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 14:29:30.678723 systemd-modules-load[332]: Using 2 probe threads Oct 19 14:29:30.888000 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 14:29:30.827427 systemd-modules-load[332]: Inserted module 'br_netfilter' Oct 19 14:29:30.875070 systemd-vconsole-setup[337]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 19 14:29:30.910502 kernel: audit: type=1130 audit(1792420170.888:4): 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 14:29:30.910809 systemd[1]: Started systemd-journald.service - Journal Service. Oct 19 14:29:30.915000 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 14:29:30.922997 kernel: audit: type=1130 audit(1792420170.915:5): 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 14:29:30.924235 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 19 14:29:30.930000 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 14:29:30.932567 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 19 14:29:30.935000 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 14:29:30.935000 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 14:29:30.932811 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 19 14:29:30.964188 kernel: audit: type=1130 audit(1792420170.930:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 14:29:30.953004 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 19 14:29:30.968444 kernel: audit: type=1130 audit(1792420170.935:7): 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 14:29:30.968482 kernel: audit: type=1131 audit(1792420170.935:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 14:29:30.967000 audit: BPF prog-id=5 op=LOAD Oct 19 14:29:30.970666 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 19 14:29:30.974195 kernel: audit: type=1334 audit(1792420170.967:9): prog-id=5 op=LOAD Oct 19 14:29:30.990162 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 19 14:29:31.020058 systemd-tmpfiles[354]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Oct 19 14:29:31.020306 systemd-tmpfiles[354]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 19 14:29:31.048031 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 19 14:29:31.046000 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 14:29:31.062006 kernel: audit: type=1130 audit(1792420171.046:10): 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 14:29:31.063537 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 19 14:29:31.071000 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 14:29:31.079999 kernel: audit: type=1130 audit(1792420171.071:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 19 14:29:31.081148 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 19 14:29:31.135935 dracut-cmdline[366]: dracut-112 Oct 19 14:29:31.146465 systemd-resolved[353]: Positive Trust Anchors: Oct 19 14:29:31.148431 systemd-resolved[353]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 19 14:29:31.157085 dracut-cmdline[366]: 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=d88eec92645b2922a7afec0deee119d005dd43b526057d21bd6466ee9a4ad3b2 Oct 19 14:29:31.148688 systemd-resolved[353]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 19 14:29:31.149206 systemd-resolved[353]: 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 14:29:31.457045 kernel: Loading iSCSI transport class v2.0-870. Oct 19 14:29:31.477174 kernel: random: crng init done Oct 19 14:29:31.495779 systemd-resolved[353]: Defaulting to hostname 'linux'. Oct 19 14:29:31.499688 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 19 14:29:31.503000 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 14:29:31.505423 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 19 14:29:31.518125 kernel: iscsi: registered transport (tcp) Oct 19 14:29:31.546370 kernel: iscsi: registered transport (qla4xxx) Oct 19 14:29:31.546451 kernel: QLogic iSCSI HBA Driver Oct 19 14:29:31.619930 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 19 14:29:31.656758 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 19 14:29:31.660000 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 14:29:31.665542 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 19 14:29:31.724193 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 19 14:29:31.725000 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 14:29:31.729000 audit: BPF prog-id=6 op=LOAD Oct 19 14:29:31.729000 audit: BPF prog-id=7 op=LOAD Oct 19 14:29:31.732200 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 19 14:29:31.807235 systemd-udevd[502]: Using default interface naming scheme 'v261'. Oct 19 14:29:31.848513 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 19 14:29:31.857000 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 14:29:31.864213 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 19 14:29:31.877000 audit: BPF prog-id=8 op=LOAD Oct 19 14:29:31.885992 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 19 14:29:31.934602 dracut-pre-trigger[510]: rd.md=0: removing MD RAID activation Oct 19 14:29:31.996373 systemd-networkd[517]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Oct 19 14:29:32.000643 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 19 14:29:32.014000 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 14:29:32.019130 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 19 14:29:32.042744 systemd-networkd[517]: lo: Link UP Oct 19 14:29:32.045139 systemd-networkd[517]: lo: Gained carrier Oct 19 14:29:32.051000 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 14:29:32.048915 systemd[1]: Started systemd-networkd.service - Network Management. Oct 19 14:29:32.053366 systemd[1]: Reached target network.target - Network. Oct 19 14:29:32.265437 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 19 14:29:32.275000 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 14:29:32.279533 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 19 14:29:32.560043 kernel: nvme nvme0: using unchecked data buffer Oct 19 14:29:32.669118 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 19 14:29:32.669191 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 19 14:29:32.709992 kernel: PTP clock support registered Oct 19 14:29:32.752620 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 19 14:29:32.757610 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 14:29:32.768000 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 14:29:32.770375 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 14:29:32.781505 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 14:29:32.839398 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 19 14:29:32.839474 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Oct 19 14:29:32.844092 systemd-vconsole-setup[641]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 19 14:29:32.855010 kernel: ena 0000:00:05.0: ENA device version: 0.10 Oct 19 14:29:32.855586 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Oct 19 14:29:32.861262 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 14:29:32.863000 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 14:29:32.941379 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80110000, mac addr 06:ff:c1:88:ef:97 Oct 19 14:29:32.949926 (udev-worker)[574]: Network interface NamePolicy= disabled on kernel command line. Oct 19 14:29:32.965545 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Oct 19 14:29:32.967787 systemd-networkd[517]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 19 14:29:32.986103 systemd-networkd[517]: eth0: Link UP Oct 19 14:29:32.987249 systemd-networkd[517]: eth0: Gained carrier Oct 19 14:29:32.999089 systemd-networkd[517]: eth0: DHCPv4 address 172.31.29.119/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 19 14:29:33.022271 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 19 14:29:33.028000 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 14:29:33.058214 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Oct 19 14:29:33.109937 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Oct 19 14:29:33.137488 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Oct 19 14:29:33.138175 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 19 14:29:33.138898 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 19 14:29:33.139849 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 19 14:29:33.144094 systemd[1]: Mounting oem.mount - /oem... Oct 19 14:29:33.152709 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 19 14:29:33.198602 disk-uuid[694]: Primary Header is updated. Oct 19 14:29:33.198602 disk-uuid[694]: Secondary Entries is updated. Oct 19 14:29:33.198602 disk-uuid[694]: Secondary Header is updated. Oct 19 14:29:33.207220 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (691) Oct 19 14:29:33.217500 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 11bf864b-f151-40ff-8dd9-c7b41b5bd6bf Oct 19 14:29:33.217579 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-lib) checksum algorithm Oct 19 14:29:33.235320 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 19 14:29:33.235407 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 19 14:29:33.238384 systemd[1]: Mounted oem.mount - /oem. Oct 19 14:29:33.245152 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 19 14:29:34.336883 disk-uuid[695]: Warning: The kernel is still using the old partition table. Oct 19 14:29:34.336883 disk-uuid[695]: The new table will be used at the next reboot or after you Oct 19 14:29:34.336883 disk-uuid[695]: run partprobe(8) or kpartx(8) Oct 19 14:29:34.336883 disk-uuid[695]: The operation has completed successfully. Oct 19 14:29:34.353408 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 19 14:29:34.394061 ignition[713]: Ignition 2.27.0 Oct 19 14:29:34.353661 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 19 14:29:34.394082 ignition[713]: Stage: fetch-offline Oct 19 14:29:34.676224 systemd-networkd[517]: eth0: Gained IPv6LL Oct 19 14:29:34.395201 ignition[713]: no config dir at "/run/ignition/base.d" Oct 19 14:29:34.395239 ignition[713]: no config dir at "/etc/ignition/base.d" Oct 19 14:29:34.395321 ignition[713]: no config dir at "/usr/lib/ignition/base.d" Oct 19 14:29:34.395332 ignition[713]: no configs found in "base.d" across system config directories Oct 19 14:29:34.395355 ignition[713]: no config dir at "/run/ignition/base.platform.d/aws" Oct 19 14:29:34.395371 ignition[713]: no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 14:29:34.395396 ignition[713]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 14:29:34.395405 ignition[713]: no configs found in "base.platform.d/aws" across system config directories Oct 19 14:29:34.396646 ignition[713]: Ignition finished successfully Oct 19 14:29:34.890000 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 14:29:34.890000 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 14:29:34.892484 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 19 14:29:34.895000 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 14:29:34.902392 systemd[1]: Mounting boot.mount - Boot partition... Oct 19 14:29:34.907261 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 19 14:29:34.947303 ignition[893]: Ignition 2.27.0 Oct 19 14:29:34.947485 ignition[893]: Stage: fetch Oct 19 14:29:34.949720 ignition[893]: no config dir at "/run/ignition/base.d" Oct 19 14:29:34.949739 ignition[893]: no config dir at "/etc/ignition/base.d" Oct 19 14:29:34.949769 ignition[893]: no config dir at "/usr/lib/ignition/base.d" Oct 19 14:29:34.949779 ignition[893]: no configs found in "base.d" across system config directories Oct 19 14:29:34.949801 ignition[893]: no config dir at "/run/ignition/base.platform.d/aws" Oct 19 14:29:34.949817 ignition[893]: no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 14:29:34.949833 ignition[893]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 14:29:34.949842 ignition[893]: no configs found in "base.platform.d/aws" across system config directories Oct 19 14:29:34.950056 ignition[893]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 14:29:34.974503 ignition[893]: PUT result: OK Oct 19 14:29:34.989322 ignition[893]: reading system config file "/run/ignition/user.ign" Oct 19 14:29:34.989354 ignition[893]: no config at "/run/ignition/user.ign" Oct 19 14:29:34.989366 ignition[893]: reading system config file "/etc/ignition/user.ign" Oct 19 14:29:34.989382 ignition[893]: no config at "/etc/ignition/user.ign" Oct 19 14:29:34.989393 ignition[893]: reading system config file "/usr/lib/ignition/user.ign" Oct 19 14:29:34.995154 ignition[893]: no config at "/usr/lib/ignition/user.ign" Oct 19 14:29:34.995212 ignition[893]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 14:29:35.009361 ignition[893]: PUT result: OK Oct 19 14:29:35.009989 ignition[893]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Oct 19 14:29:35.014838 ignition[893]: GET result: OK Oct 19 14:29:35.014931 ignition[893]: parsing config with SHA512: d7de79402b2718823c882faa94155feac8b2ec33d1febd7f28b7c372022482ba5f39d5a88d29631c1256d404e2b03767ecbdcd81fd60e8da5e529a9f13aac5ae Oct 19 14:29:35.030564 unknown[893]: fetched base config from "system" Oct 19 14:29:35.032328 unknown[893]: fetched base config from "system" Oct 19 14:29:35.033588 ignition[893]: fetch: fetch complete Oct 19 14:29:35.032562 unknown[893]: fetched user config from "aws" Oct 19 14:29:35.033601 ignition[893]: fetch: fetch passed Oct 19 14:29:35.038619 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 19 14:29:35.033716 ignition[893]: Ignition finished successfully Oct 19 14:29:35.055000 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 14:29:35.062164 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 19 14:29:35.073225 systemd[1]: Mounted boot.mount - Boot partition. Oct 19 14:29:35.103347 ignition[904]: Ignition 2.27.0 Oct 19 14:29:35.103376 ignition[904]: Stage: kargs Oct 19 14:29:35.103865 ignition[904]: no config dir at "/run/ignition/base.d" Oct 19 14:29:35.103885 ignition[904]: no config dir at "/etc/ignition/base.d" Oct 19 14:29:35.117786 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 19 14:29:35.118000 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 14:29:35.103918 ignition[904]: no config dir at "/usr/lib/ignition/base.d" Oct 19 14:29:35.122884 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 19 14:29:35.103929 ignition[904]: no configs found in "base.d" across system config directories Oct 19 14:29:35.104018 ignition[904]: no config dir at "/run/ignition/base.platform.d/aws" Oct 19 14:29:35.104038 ignition[904]: no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 14:29:35.104057 ignition[904]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 14:29:35.104068 ignition[904]: no configs found in "base.platform.d/aws" across system config directories Oct 19 14:29:35.104289 ignition[904]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 14:29:35.106714 ignition[904]: PUT result: OK Oct 19 14:29:35.112650 ignition[904]: kargs: kargs passed Oct 19 14:29:35.112762 ignition[904]: Ignition finished successfully Oct 19 14:29:35.181703 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 19 14:29:35.183552 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 19 14:29:35.183000 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 14:29:35.185552 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 19 14:29:35.188000 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 14:29:35.185806 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 19 14:29:35.203000 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 14:29:35.190836 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 19 14:29:35.191133 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 19 14:29:35.205721 systemd[1]: Unmounting oem.mount - /oem... Oct 19 14:29:35.232990 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 11bf864b-f151-40ff-8dd9-c7b41b5bd6bf Oct 19 14:29:35.236033 systemd[1]: oem.mount: Deactivated successfully. Oct 19 14:29:35.236361 systemd[1]: Unmounted oem.mount - /oem. Oct 19 14:29:35.275792 ignition[915]: Ignition 2.27.0 Oct 19 14:29:35.275826 ignition[915]: Stage: disks Oct 19 14:29:35.276297 ignition[915]: no config dir at "/run/ignition/base.d" Oct 19 14:29:35.276317 ignition[915]: no config dir at "/etc/ignition/base.d" Oct 19 14:29:35.276353 ignition[915]: no config dir at "/usr/lib/ignition/base.d" Oct 19 14:29:35.289471 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 19 14:29:35.276364 ignition[915]: no configs found in "base.d" across system config directories Oct 19 14:29:35.294000 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 14:29:35.296623 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 19 14:29:35.276387 ignition[915]: no config dir at "/run/ignition/base.platform.d/aws" Oct 19 14:29:35.298709 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 19 14:29:35.276403 ignition[915]: no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 14:29:35.304898 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 19 14:29:35.276420 ignition[915]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 14:29:35.276430 ignition[915]: no configs found in "base.platform.d/aws" across system config directories Oct 19 14:29:35.276607 ignition[915]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 14:29:35.331585 systemd[1]: Reached target sysinit.target - System Initialization. Oct 19 14:29:35.279031 ignition[915]: PUT result: OK Oct 19 14:29:35.332783 systemd[1]: Reached target basic.target - Basic System. Oct 19 14:29:35.286097 ignition[915]: disks: disks passed Oct 19 14:29:35.286269 ignition[915]: Ignition finished successfully Oct 19 14:29:35.348047 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 19 14:29:35.390708 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 19 14:29:35.393000 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 14:29:35.397801 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 19 14:29:35.538675 systemd-fsck[933]: ROOT: clean, 15/1631200 files, 112378/1617920 blocks Oct 19 14:29:35.548000 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 14:29:35.545567 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 19 14:29:35.559182 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 19 14:29:35.739020 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 72328907-5a6c-4050-8161-ea8b7b528eff r/w with ordered data mode. Quota mode: none. Oct 19 14:29:35.741025 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 19 14:29:35.746288 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 19 14:29:35.778787 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 19 14:29:35.784906 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent skipped, no trigger condition checks were met. Oct 19 14:29:35.786018 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Oct 19 14:29:35.786087 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 19 14:29:35.819453 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 19 14:29:35.821517 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 19 14:29:37.419985 kernel: loop1: detected capacity change from 0 to 44497 Oct 19 14:29:37.572512 kernel: loop1: p1 p2 p3 Oct 19 14:29:37.730166 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:37.730226 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:37.730254 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:37.731809 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:37.733029 systemd-confext[1025]: device-mapper: reload ioctl on loop1p1-12-verity (254:1) failed: Invalid argument Oct 19 14:29:37.746994 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:37.947128 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Oct 19 14:29:38.021044 kernel: loop2: detected capacity change from 0 to 44497 Oct 19 14:29:38.030403 kernel: loop2: p1 p2 p3 Oct 19 14:29:38.045249 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:38.045393 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:38.047508 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:38.048900 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:38.049063 (sd-merge)[1036]: device-mapper: reload ioctl on loop2p1-16-verity (254:1) failed: Invalid argument Oct 19 14:29:38.062264 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:38.103013 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Oct 19 14:29:38.103609 (sd-merge)[1036]: Using extensions '00-flatcar-default.raw'. Oct 19 14:29:38.107286 (sd-merge)[1036]: Merged extensions into '/sysroot/etc'. Oct 19 14:29:38.118716 initrd-setup-root[1043]: /etc 00-flatcar-default Mon 2026-10-19 14:29:31 UTC Oct 19 14:29:38.128466 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 19 14:29:38.128000 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 14:29:38.144763 kernel: kauditd_printk_skb: 24 callbacks suppressed Oct 19 14:29:38.137135 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 19 14:29:38.152301 kernel: audit: type=1130 audit(1792420178.128:36): 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 14:29:38.219162 ignition[1048]: INFO : Ignition 2.27.0 Oct 19 14:29:38.219162 ignition[1048]: INFO : Stage: mount Oct 19 14:29:38.224398 ignition[1048]: INFO : no config dir at "/run/ignition/base.d" Oct 19 14:29:38.224398 ignition[1048]: INFO : no config dir at "/etc/ignition/base.d" Oct 19 14:29:38.224398 ignition[1048]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 19 14:29:38.224398 ignition[1048]: INFO : no configs found in "base.d" across system config directories Oct 19 14:29:38.224398 ignition[1048]: INFO : no config dir at "/run/ignition/base.platform.d/aws" Oct 19 14:29:38.224398 ignition[1048]: INFO : no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 14:29:38.224398 ignition[1048]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 14:29:38.224398 ignition[1048]: INFO : no configs found in "base.platform.d/aws" across system config directories Oct 19 14:29:38.224398 ignition[1048]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 14:29:38.224398 ignition[1048]: INFO : PUT result: OK Oct 19 14:29:38.251000 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 14:29:38.269691 kernel: audit: type=1130 audit(1792420178.251:37): 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 14:29:38.269728 ignition[1048]: INFO : mount: mount passed Oct 19 14:29:38.269728 ignition[1048]: INFO : Ignition finished successfully Oct 19 14:29:38.243530 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 19 14:29:38.258806 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 19 14:29:38.302099 systemd[1]: Mounting oem.mount - /oem... Oct 19 14:29:38.332999 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1056) Oct 19 14:29:38.337803 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 11bf864b-f151-40ff-8dd9-c7b41b5bd6bf Oct 19 14:29:38.337900 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-lib) checksum algorithm Oct 19 14:29:38.348110 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 19 14:29:38.348227 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 19 14:29:38.353491 systemd[1]: Mounted oem.mount - /oem. Oct 19 14:29:38.358253 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 19 14:29:38.387393 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 19 14:29:38.427819 ignition[1075]: INFO : Ignition 2.27.0 Oct 19 14:29:38.427819 ignition[1075]: INFO : Stage: files Oct 19 14:29:38.433482 ignition[1075]: INFO : no config dir at "/run/ignition/base.d" Oct 19 14:29:38.433482 ignition[1075]: INFO : no config dir at "/etc/ignition/base.d" Oct 19 14:29:38.433482 ignition[1075]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 19 14:29:38.433482 ignition[1075]: INFO : no configs found in "base.d" across system config directories Oct 19 14:29:38.433482 ignition[1075]: INFO : no config dir at "/run/ignition/base.platform.d/aws" Oct 19 14:29:38.433482 ignition[1075]: INFO : no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 14:29:38.433482 ignition[1075]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 14:29:38.433482 ignition[1075]: INFO : no configs found in "base.platform.d/aws" across system config directories Oct 19 14:29:38.433482 ignition[1075]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 14:29:38.433482 ignition[1075]: INFO : PUT result: OK Oct 19 14:29:38.469049 ignition[1075]: DEBUG : files: compiled without relabeling support, skipping Oct 19 14:29:38.469049 ignition[1075]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 19 14:29:38.469049 ignition[1075]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 19 14:29:38.469049 ignition[1075]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 19 14:29:38.483075 ignition[1075]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 19 14:29:38.487497 unknown[1075]: wrote ssh authorized keys file for user: core Oct 19 14:29:38.490825 ignition[1075]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 19 14:29:38.490825 ignition[1075]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 19 14:29:38.490825 ignition[1075]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 19 14:29:38.490825 ignition[1075]: INFO : files: op(4): [started] processing unit "etcd-member.service" Oct 19 14:29:38.521344 ignition[1075]: 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 14:29:38.527717 ignition[1075]: 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 14:29:38.527717 ignition[1075]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Oct 19 14:29:38.527717 ignition[1075]: INFO : files: op(6): [started] setting preset to enabled for "etcd-member.service" Oct 19 14:29:38.527717 ignition[1075]: INFO : files: op(6): [finished] setting preset to enabled for "etcd-member.service" Oct 19 14:29:38.527717 ignition[1075]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 19 14:29:38.527717 ignition[1075]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 19 14:29:38.527717 ignition[1075]: INFO : files: files passed Oct 19 14:29:38.527717 ignition[1075]: INFO : Ignition finished successfully Oct 19 14:29:38.539000 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 14:29:38.575448 kernel: audit: type=1130 audit(1792420178.539:38): 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 14:29:38.529435 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 19 14:29:38.548087 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 19 14:29:38.584147 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 19 14:29:38.600086 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 19 14:29:38.605541 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 19 14:29:38.612000 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 14:29:38.612000 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 14:29:38.623066 kernel: audit: type=1130 audit(1792420178.612: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 14:29:38.623106 kernel: audit: type=1131 audit(1792420178.612:40): 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 14:29:38.668597 initrd-setup-root-after-ignition[1108]: grep: Oct 19 14:29:38.668597 initrd-setup-root-after-ignition[1112]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 19 14:29:38.676065 initrd-setup-root-after-ignition[1108]: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 19 14:29:38.676065 initrd-setup-root-after-ignition[1108]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 19 14:29:38.690107 kernel: loop3: detected capacity change from 0 to 44497 Oct 19 14:29:38.700004 kernel: loop3: p1 p2 p3 Oct 19 14:29:38.719017 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:38.719087 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:38.722820 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:38.728743 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:38.728892 systemd-confext[1114]: device-mapper: reload ioctl on loop3p1-19-verity (254:2) failed: Invalid argument Oct 19 14:29:38.744010 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:38.790003 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Oct 19 14:29:38.832013 kernel: loop4: detected capacity change from 0 to 44497 Oct 19 14:29:38.845061 kernel: loop4: p1 p2 p3 Oct 19 14:29:38.857740 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:38.857810 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:38.861527 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:38.863613 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:38.863740 (sd-merge)[1122]: device-mapper: reload ioctl on loop4p1-23-verity (254:2) failed: Invalid argument Oct 19 14:29:38.884003 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:38.924180 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Oct 19 14:29:38.926064 (sd-merge)[1122]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 19 14:29:38.954990 kernel: loop4: detected capacity change from 0 to 305992 Oct 19 14:29:38.962005 kernel: loop4: p1 p2 p3 Oct 19 14:29:38.985640 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:38.985737 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:38.989721 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:38.991089 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:38.991146 systemd-sysext[1130]: device-mapper: reload ioctl on loop4p1-27-verity (254:2) failed: Invalid argument Oct 19 14:29:39.010010 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:39.091166 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 14:29:39.163987 kernel: loop5: detected capacity change from 0 to 158624 Oct 19 14:29:39.177976 kernel: loop5: p1 p2 p3 Oct 19 14:29:39.233432 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:39.233503 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:39.233541 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:39.235591 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:39.237094 systemd-sysext[1130]: device-mapper: reload ioctl on loop5p1-31-verity (254:2) failed: Invalid argument Oct 19 14:29:39.244973 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:39.457041 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 14:29:39.490021 kernel: loop6: detected capacity change from 0 to 404352 Oct 19 14:29:39.535069 kernel: loop6: p1 p2 p3 Oct 19 14:29:39.602472 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:39.602553 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:39.602596 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:39.605606 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:39.605751 systemd-sysext[1130]: device-mapper: reload ioctl on loop6p1-35-verity (254:2) failed: Invalid argument Oct 19 14:29:39.612975 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:39.873999 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 14:29:39.972999 kernel: loop7: detected capacity change from 0 to 305992 Oct 19 14:29:39.981986 kernel: loop7: p1 p2 p3 Oct 19 14:29:39.993844 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:39.993918 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:39.993966 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:39.996923 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:39.997014 (sd-merge)[1154]: device-mapper: reload ioctl on loop7p1-39-verity (254:2) failed: Invalid argument Oct 19 14:29:40.005257 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:40.063259 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Oct 19 14:29:40.068013 kernel: loop1: detected capacity change from 0 to 158624 Oct 19 14:29:40.076992 kernel: loop1: p1 p2 p3 Oct 19 14:29:40.086225 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:40.086306 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:40.086333 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:40.089587 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:40.089617 (sd-merge)[1154]: device-mapper: reload ioctl on loop1p1-43-verity (254:3) failed: Invalid argument Oct 19 14:29:40.096993 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:40.170022 kernel: erofs (device dm-3): mounted with root inode @ nid 39. Oct 19 14:29:40.174996 kernel: loop3: detected capacity change from 0 to 404352 Oct 19 14:29:40.185136 kernel: loop3: p1 p2 p3 Oct 19 14:29:40.193992 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:40.194068 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:40.194108 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:40.196146 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:40.197607 (sd-merge)[1154]: device-mapper: reload ioctl on loop3p1-47-verity (254:4) failed: Invalid argument Oct 19 14:29:40.213028 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:40.297996 kernel: erofs (device dm-4): mounted with root inode @ nid 39. Oct 19 14:29:40.301233 (sd-merge)[1154]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-ami-9999.9.9+enable-nvidia-580-2.raw'. Oct 19 14:29:40.310925 (sd-merge)[1154]: Merged extensions into '/sysroot/usr'. Oct 19 14:29:40.317795 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 19 14:29:40.324000 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 14:29:40.341102 kernel: audit: type=1130 audit(1792420180.324:41): 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 14:29:40.331605 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 19 14:29:40.384186 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 19 14:29:40.384557 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 19 14:29:40.394000 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 14:29:40.395378 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Oct 19 14:29:40.394000 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 14:29:40.396226 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 19 14:29:40.421196 kernel: audit: type=1130 audit(1792420180.394: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 14:29:40.413814 systemd[1]: dracut-mount.service - dracut mount hook skipped, no trigger condition checks were met. Oct 19 14:29:40.426406 kernel: audit: type=1131 audit(1792420180.394:43): 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 14:29:40.415469 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 19 14:29:40.469048 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 19 14:29:40.476000 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 14:29:40.482124 kernel: audit: type=1130 audit(1792420180.476: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 14:29:40.482118 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 19 14:29:40.523401 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 19 14:29:40.527407 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 19 14:29:40.531041 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 19 14:29:40.534524 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 19 14:29:40.564000 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 14:29:40.574633 kernel: audit: type=1131 audit(1792420180.564:45): 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 14:29:40.544503 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 19 14:29:40.548489 systemd[1]: Stopped target timers.target - Timer Units. Oct 19 14:29:40.589000 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 14:29:40.556175 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 19 14:29:40.556486 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Oct 19 14:29:40.560540 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 19 14:29:40.560877 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 19 14:29:40.571536 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 19 14:29:40.577608 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 19 14:29:40.585160 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 19 14:29:40.585492 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 19 14:29:40.590770 systemd[1]: Stopped target basic.target - Basic System. Oct 19 14:29:40.598004 systemd[1]: Stopped target paths.target - Path Units. Oct 19 14:29:40.598767 systemd[1]: Stopped target slices.target - Slice Units. Oct 19 14:29:40.599614 systemd[1]: Stopped target sockets.target - Socket Units. Oct 19 14:29:40.600442 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 19 14:29:40.613391 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 19 14:29:40.620450 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 19 14:29:40.621172 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 19 14:29:40.627579 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 19 14:29:40.629414 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 19 14:29:40.630005 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 19 14:29:40.638903 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 19 14:29:40.649129 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Oct 19 14:29:40.654031 systemd[1]: Stopped target swap.target - Swaps. Oct 19 14:29:40.665297 systemd[1]: iscsid.socket: Deactivated successfully. Oct 19 14:29:40.668389 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 19 14:29:40.714561 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 19 14:29:40.717756 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 19 14:29:40.724587 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Oct 19 14:29:40.732000 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 14:29:40.740000 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 14:29:40.724829 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Oct 19 14:29:40.741000 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 14:29:40.728979 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 19 14:29:40.762000 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 14:29:40.729246 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 19 14:29:40.768000 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 14:29:40.733638 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 19 14:29:40.775000 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 14:29:40.779000 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 14:29:40.734019 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 19 14:29:40.741894 systemd[1]: ignition-files.service: Deactivated successfully. Oct 19 14:29:40.742272 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 19 14:29:40.745940 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 19 14:29:40.810000 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 14:29:40.810000 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 14:29:40.755716 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 19 14:29:40.758562 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 19 14:29:40.763623 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 19 14:29:40.829178 ignition[1190]: INFO : Ignition 2.27.0 Oct 19 14:29:40.829178 ignition[1190]: INFO : Stage: umount Oct 19 14:29:40.829178 ignition[1190]: INFO : no config dir at "/run/ignition/base.d" Oct 19 14:29:40.829178 ignition[1190]: INFO : no config dir at "/etc/ignition/base.d" Oct 19 14:29:40.829178 ignition[1190]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 19 14:29:40.829178 ignition[1190]: INFO : no configs found in "base.d" across system config directories Oct 19 14:29:40.829178 ignition[1190]: INFO : no config dir at "/run/ignition/base.platform.d/aws" Oct 19 14:29:40.829178 ignition[1190]: INFO : no config dir at "/etc/ignition/base.platform.d/aws" Oct 19 14:29:40.829178 ignition[1190]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 19 14:29:40.829178 ignition[1190]: INFO : no configs found in "base.platform.d/aws" across system config directories Oct 19 14:29:40.829178 ignition[1190]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 19 14:29:40.829178 ignition[1190]: INFO : PUT result: OK Oct 19 14:29:40.845000 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 14:29:40.846000 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 14:29:40.849000 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 14:29:40.850000 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 14:29:40.764014 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 19 14:29:40.905117 ignition[1190]: INFO : umount: umount passed Oct 19 14:29:40.905117 ignition[1190]: INFO : Ignition finished successfully Oct 19 14:29:40.771210 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 19 14:29:40.771466 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 19 14:29:40.776391 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 19 14:29:40.776766 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 19 14:29:40.804642 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 19 14:29:40.806473 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 19 14:29:40.842185 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 19 14:29:40.843071 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 19 14:29:40.937000 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 14:29:40.846435 systemd[1]: Stopped target network.target - Network. Oct 19 14:29:40.847247 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 19 14:29:40.847334 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 19 14:29:40.959000 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 14:29:40.847735 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 19 14:29:40.847805 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 19 14:29:40.850239 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 19 14:29:40.969000 audit: BPF prog-id=5 op=UNLOAD Oct 19 14:29:40.850312 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 19 14:29:40.852351 systemd[1]: Stopping systemd-networkd.service - Network Management... Oct 19 14:29:40.853161 systemd-networkd[517]: eth0: DHCP lease lost Oct 19 14:29:40.969000 audit: BPF prog-id=8 op=UNLOAD Oct 19 14:29:40.877164 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 19 14:29:40.929875 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 19 14:29:40.931100 systemd[1]: Stopped systemd-networkd.service - Network Management. Oct 19 14:29:40.951535 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 19 14:29:40.951855 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 19 14:29:40.964870 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Oct 19 14:29:40.965639 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 19 14:29:40.981102 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 19 14:29:40.984121 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 19 14:29:40.984805 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Oct 19 14:29:40.987852 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 19 14:29:41.000685 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 19 14:29:41.079080 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 19 14:29:41.085546 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 19 14:29:41.090000 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 14:29:41.091739 systemd[1]: systemd-udevd.service: Consumed 2.925s CPU time over 9.352s wall clock time. Oct 19 14:29:41.097194 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 19 14:29:41.097294 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 19 14:29:41.107276 systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully. Oct 19 14:29:41.107391 systemd[1]: Closed systemd-udevd-varlink.socket - udev Varlink Socket. Oct 19 14:29:41.109000 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 14:29:41.110000 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 14:29:41.110000 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 14:29:41.110371 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 19 14:29:41.110444 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 19 14:29:41.110913 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 19 14:29:41.111000 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 19 14:29:41.145000 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 14:29:41.111373 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 19 14:29:41.161000 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 14:29:41.111432 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 19 14:29:41.173000 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 14:29:41.133505 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 19 14:29:41.179000 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 14:29:41.180000 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 14:29:41.139035 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 19 14:29:41.186000 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 14:29:41.142616 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 19 14:29:41.146610 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 19 14:29:41.146716 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 19 14:29:41.200000 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 14:29:41.200000 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 14:29:41.162793 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 19 14:29:41.162884 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 19 14:29:41.175024 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 19 14:29:41.175119 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 19 14:29:41.180420 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 19 14:29:41.180520 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 14:29:41.182813 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 19 14:29:41.185074 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 19 14:29:41.192534 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 19 14:29:41.193869 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 19 14:29:41.202376 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 19 14:29:41.219589 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 19 14:29:41.272531 systemd[1]: Switching root. Oct 19 14:29:41.345013 systemd-journald[331]: Received SIGTERM from PID 1 (systemd). Oct 19 14:29:41.345105 systemd-journald[331]: Journal stopped Oct 19 14:29:46.677496 kernel: SELinux: policy capability network_peer_controls=1 Oct 19 14:29:46.677685 kernel: SELinux: policy capability open_perms=1 Oct 19 14:29:46.677716 kernel: SELinux: policy capability extended_socket_class=1 Oct 19 14:29:46.677743 kernel: SELinux: policy capability always_check_network=0 Oct 19 14:29:46.677780 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 19 14:29:46.677814 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 19 14:29:46.677842 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 19 14:29:46.677891 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 19 14:29:46.677938 kernel: SELinux: policy capability userspace_initial_context=0 Oct 19 14:29:46.678089 kernel: SELinux: policy capability netlink_xperm=0 Oct 19 14:29:46.678138 kernel: SELinux: policy capability netif_wildcard=0 Oct 19 14:29:46.678193 kernel: SELinux: policy capability genfs_seclabel_wildcard=0 Oct 19 14:29:46.678252 kernel: SELinux: policy capability functionfs_seclabel=0 Oct 19 14:29:46.678303 systemd[1]: Successfully loaded SELinux policy in 144.819ms. Oct 19 14:29:46.678365 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 23.446ms. Oct 19 14:29:46.678428 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 14:29:46.678488 systemd[1]: Detected virtualization amazon. Oct 19 14:29:46.678545 systemd[1]: Detected architecture arm64. Oct 19 14:29:46.678595 systemd[1]: Detected first boot. Oct 19 14:29:46.678662 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 19 14:29:46.678712 kernel: kauditd_printk_skb: 32 callbacks suppressed Oct 19 14:29:46.678764 kernel: audit: type=1334 audit(1792420183.610:78): prog-id=9 op=LOAD Oct 19 14:29:46.678820 kernel: audit: type=1334 audit(1792420183.610:79): prog-id=9 op=UNLOAD Oct 19 14:29:46.678877 zram_generator::config[1231]: No configuration found. Oct 19 14:29:46.678978 kernel: NET: Registered PF_VSOCK protocol family Oct 19 14:29:46.679028 systemd[1]: Applying preset policy. Oct 19 14:29:46.679093 systemd[1]: Created symlink '/etc/systemd/system/multi-user.target.wants/etcd-member.service' → '/usr/lib/systemd/system/etcd-member.service'. Oct 19 14:29:46.679136 systemd[1]: Populated /etc with preset unit settings. Oct 19 14:29:46.679183 kernel: audit: type=1334 audit(1792420185.738:80): prog-id=10 op=LOAD Oct 19 14:29:46.679239 kernel: audit: type=1334 audit(1792420185.738:81): prog-id=2 op=UNLOAD Oct 19 14:29:46.679293 kernel: audit: type=1334 audit(1792420185.740:82): prog-id=11 op=LOAD Oct 19 14:29:46.679334 kernel: audit: type=1334 audit(1792420185.741:83): prog-id=12 op=LOAD Oct 19 14:29:46.679388 kernel: audit: type=1334 audit(1792420185.741:84): prog-id=3 op=UNLOAD Oct 19 14:29:46.679451 kernel: audit: type=1334 audit(1792420185.741:85): prog-id=4 op=UNLOAD Oct 19 14:29:46.679500 kernel: audit: type=1334 audit(1792420185.750:86): prog-id=13 op=LOAD Oct 19 14:29:46.679535 kernel: audit: type=1334 audit(1792420185.750:87): prog-id=10 op=UNLOAD Oct 19 14:29:46.679581 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 19 14:29:46.679638 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 19 14:29:46.679697 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 19 14:29:46.679759 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 19 14:29:46.679819 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 19 14:29:46.679877 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 19 14:29:46.679911 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 19 14:29:46.679971 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 19 14:29:46.680032 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 19 14:29:46.680080 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 19 14:29:46.680110 systemd[1]: Created slice user.slice - User and Session Slice. Oct 19 14:29:46.680140 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 19 14:29:46.680170 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 19 14:29:46.680229 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 19 14:29:46.680260 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 19 14:29:46.680290 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 19 14:29:46.680331 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 19 14:29:46.680371 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 19 14:29:46.680401 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 19 14:29:46.680432 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 19 14:29:46.680462 systemd[1]: Reached target imports.target - Image Downloads. Oct 19 14:29:46.680490 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 19 14:29:46.680535 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 19 14:29:46.680583 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 19 14:29:46.680617 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 19 14:29:46.680647 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 19 14:29:46.680688 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 19 14:29:46.680722 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Oct 19 14:29:46.680760 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Oct 19 14:29:46.680790 systemd[1]: Reached target slices.target - Slice Units. Oct 19 14:29:46.680837 systemd[1]: Reached target swap.target - Swaps. Oct 19 14:29:46.680868 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 19 14:29:46.680897 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 19 14:29:46.680926 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 19 14:29:46.681070 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 19 14:29:46.681104 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Oct 19 14:29:46.681134 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 19 14:29:46.681162 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 19 14:29:46.681191 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Oct 19 14:29:46.681247 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Oct 19 14:29:46.681278 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Oct 19 14:29:46.681315 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Oct 19 14:29:46.681345 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 19 14:29:46.685493 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Oct 19 14:29:46.685573 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Oct 19 14:29:46.685609 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Oct 19 14:29:46.685652 systemd[1]: Listening on systemd-report-basic.socket - Report System Basic Metrics Socket. Oct 19 14:29:46.685695 systemd[1]: Listening on systemd-report-cgroup.socket - CGroup Report Varlink Socket. Oct 19 14:29:46.685774 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Oct 19 14:29:46.685833 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Oct 19 14:29:46.685891 systemd[1]: Listening on systemd-storage-block.socket - Simple Block Device Backed Storage Provider. Oct 19 14:29:46.686015 systemd[1]: Listening on systemd-storage-fs.socket - Simple File System Backed Storage Provider. Oct 19 14:29:46.686051 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 19 14:29:46.686124 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 19 14:29:46.686184 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 19 14:29:46.686239 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 19 14:29:46.686291 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 19 14:29:46.686349 systemd[1]: Mounting media.mount - External Media Directory... Oct 19 14:29:46.686402 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 19 14:29:46.686451 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 19 14:29:46.686508 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Oct 19 14:29:46.686559 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 19 14:29:46.686617 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 19 14:29:46.686676 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Oct 19 14:29:46.686734 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 19 14:29:46.686791 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 19 14:29:46.686823 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Oct 19 14:29:46.686871 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 19 14:29:46.686928 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 19 14:29:46.687045 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Oct 19 14:29:46.687105 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 19 14:29:46.687156 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 19 14:29:46.687217 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 14:29:46.687267 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 19 14:29:46.687325 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 19 14:29:46.687388 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 19 14:29:46.687448 systemd[1]: Reached target time-set.target - System Time Set. Oct 19 14:29:46.687500 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 19 14:29:46.687550 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 19 14:29:46.687600 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 19 14:29:46.687663 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 19 14:29:46.687699 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 19 14:29:46.687729 systemd[1]: Mounted media.mount - External Media Directory. Oct 19 14:29:46.687764 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 19 14:29:46.687795 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 19 14:29:46.687823 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 19 14:29:46.687853 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 19 14:29:46.687887 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 19 14:29:46.687918 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 19 14:29:46.687982 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 19 14:29:46.688018 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 19 14:29:46.688046 kernel: fuse: init (API version 7.45) Oct 19 14:29:46.688076 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 19 14:29:46.688104 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 19 14:29:46.688140 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 19 14:29:46.688168 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 19 14:29:46.688245 systemd-journald[1298]: Collecting audit messages is enabled. Oct 19 14:29:46.688296 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 19 14:29:46.688327 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 19 14:29:46.688367 systemd-journald[1298]: Journal started Oct 19 14:29:46.688415 systemd-journald[1298]: Runtime Journal (/run/log/journal/ec21228f063f266b5d4f8ec869c54358) is 8M, max 75.2M, 67.2M free. Oct 19 14:29:46.081000 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 14:29:46.419000 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 14:29:46.424000 audit: BPF prog-id=15 op=UNLOAD Oct 19 14:29:46.424000 audit: BPF prog-id=14 op=UNLOAD Oct 19 14:29:46.427000 audit: BPF prog-id=16 op=LOAD Oct 19 14:29:46.427000 audit: BPF prog-id=17 op=LOAD Oct 19 14:29:46.428000 audit: BPF prog-id=18 op=LOAD Oct 19 14:29:46.596000 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 14:29:46.608000 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 14:29:46.608000 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 14:29:46.624000 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 14:29:46.625000 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 14:29:46.634000 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 14:29:46.648000 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 14:29:46.648000 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 14:29:46.659000 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 14:29:46.666000 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 14:29:46.666000 audit[1298]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=4 a1=ffffe5c19fd0 a2=4000 a3=0 items=0 ppid=1 pid=1298 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 14:29:46.666000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 19 14:29:46.674000 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 14:29:46.684000 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 14:29:45.728017 systemd[1]: Queued start job for default target multi-user.target. Oct 19 14:29:45.756216 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Oct 19 14:29:45.757109 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 19 14:29:46.485631 systemd-modules-load[1299]: Using 2 probe threads Oct 19 14:29:46.696000 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 14:29:46.701363 systemd[1]: Started systemd-journald.service - Journal Service. Oct 19 14:29:46.718523 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 19 14:29:46.725917 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 19 14:29:46.738136 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 19 14:29:46.748122 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 19 14:29:46.753290 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Oct 19 14:29:46.765658 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 19 14:29:46.786142 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 19 14:29:46.794223 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Oct 19 14:29:46.802304 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 19 14:29:46.818240 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 19 14:29:46.827349 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 19 14:29:46.840626 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 19 14:29:46.844458 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 19 14:29:46.873017 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 19 14:29:46.878841 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 19 14:29:46.877000 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 14:29:46.921076 systemd-journald[1298]: Time spent on flushing to /var/log/journal/ec21228f063f266b5d4f8ec869c54358 is 39.508ms for 1172 entries. Oct 19 14:29:46.921076 systemd-journald[1298]: System Journal (/var/log/journal/ec21228f063f266b5d4f8ec869c54358) is 8M, max 588.1M, 580.1M free. Oct 19 14:29:46.989330 systemd-journald[1298]: Received client request to flush runtime journal. Oct 19 14:29:46.990841 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 19 14:29:46.998000 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 14:29:47.005375 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 19 14:29:47.012000 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 14:29:47.037755 systemd-tmpfiles[1336]: ACLs are not supported, ignoring. Oct 19 14:29:47.038486 systemd-tmpfiles[1336]: ACLs are not supported, ignoring. Oct 19 14:29:47.056336 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 19 14:29:47.062000 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 14:29:47.171355 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 19 14:29:47.180000 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 14:29:47.184843 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 19 14:29:47.188000 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 14:29:47.195164 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 19 14:29:47.288238 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 19 14:29:47.292000 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 14:29:47.298741 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Oct 19 14:29:47.309000 audit: BPF prog-id=19 op=LOAD Oct 19 14:29:47.309000 audit: BPF prog-id=20 op=LOAD Oct 19 14:29:47.310000 audit: BPF prog-id=21 op=LOAD Oct 19 14:29:47.326000 audit: BPF prog-id=22 op=LOAD Oct 19 14:29:47.315155 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Oct 19 14:29:47.333198 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 19 14:29:47.344352 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 19 14:29:47.348783 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 19 14:29:47.376000 audit: BPF prog-id=23 op=LOAD Oct 19 14:29:47.377000 audit: BPF prog-id=24 op=LOAD Oct 19 14:29:47.377000 audit: BPF prog-id=25 op=LOAD Oct 19 14:29:47.382486 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 19 14:29:47.400206 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Oct 19 14:29:47.417545 systemd-tmpfiles[1369]: ACLs are not supported, ignoring. Oct 19 14:29:47.417601 systemd-tmpfiles[1369]: ACLs are not supported, ignoring. Oct 19 14:29:47.434621 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 19 14:29:47.440000 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 14:29:47.442313 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 19 14:29:47.449920 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Oct 19 14:29:47.465161 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1370 ((systemd-userd)) Oct 19 14:29:47.506429 kernel: tun: Universal TUN/TAP device driver, 1.6 Oct 19 14:29:47.508231 systemd[1]: modprobe@tun.service: Deactivated successfully. Oct 19 14:29:47.509210 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Oct 19 14:29:47.517000 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 14:29:47.517000 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 14:29:47.522000 audit: BPF prog-id=26 op=LOAD Oct 19 14:29:47.523000 audit: BPF prog-id=27 op=LOAD Oct 19 14:29:47.524000 audit: BPF prog-id=28 op=LOAD Oct 19 14:29:47.528312 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Oct 19 14:29:47.893908 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Oct 19 14:29:47.907286 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Oct 19 14:29:47.907367 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 19 14:29:47.912605 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Oct 19 14:29:47.918735 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 19 14:29:47.925693 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 19 14:29:47.936124 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Oct 19 14:29:47.950372 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 19 14:29:47.963292 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Oct 19 14:29:47.999070 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Oct 19 14:29:48.007303 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Oct 19 14:29:48.042268 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Oct 19 14:29:48.045000 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 14:29:48.055774 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 19 14:29:48.058547 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 19 14:29:48.061000 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 14:29:48.062970 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 19 14:29:48.067000 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 14:29:48.073000 audit: BPF prog-id=7 op=UNLOAD Oct 19 14:29:48.073000 audit: BPF prog-id=6 op=UNLOAD Oct 19 14:29:48.076000 audit: BPF prog-id=29 op=LOAD Oct 19 14:29:48.076000 audit: BPF prog-id=30 op=LOAD Oct 19 14:29:48.081335 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 19 14:29:48.108025 kernel: loop4: detected capacity change from 0 to 44497 Oct 19 14:29:48.118032 kernel: loop4: p1 p2 p3 Oct 19 14:29:48.163291 systemd-nsresourced[1374]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Oct 19 14:29:48.172000 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 14:29:48.178000 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 14:29:48.168139 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Oct 19 14:29:48.174742 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 19 14:29:48.191236 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:48.191418 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:48.193446 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:48.194976 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:48.195198 systemd-confext[1381]: device-mapper: reload ioctl on loop4p1-51-verity (254:5) failed: Invalid argument Oct 19 14:29:48.205013 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:48.327762 systemd-oomd[1367]: No swap; memory pressure usage will be degraded Oct 19 14:29:48.331234 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Oct 19 14:29:48.336000 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 14:29:48.334725 systemd-resolved[1368]: Positive Trust Anchors: Oct 19 14:29:48.334741 systemd-resolved[1368]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 19 14:29:48.334751 systemd-resolved[1368]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 19 14:29:48.334815 systemd-resolved[1368]: 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 14:29:48.363868 systemd-udevd[1387]: Using default interface naming scheme 'v261'. Oct 19 14:29:48.385021 systemd-resolved[1368]: Defaulting to hostname 'linux'. Oct 19 14:29:48.388168 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 19 14:29:48.390000 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 14:29:48.392040 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 19 14:29:48.543094 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 19 14:29:48.551000 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 14:29:48.554000 audit: BPF prog-id=31 op=LOAD Oct 19 14:29:48.559168 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 19 14:29:48.831968 systemd-networkd[1405]: lo: Link UP Oct 19 14:29:48.832018 systemd-networkd[1405]: lo: Gained carrier Oct 19 14:29:48.854000 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 14:29:48.851205 systemd[1]: Started systemd-networkd.service - Network Management. Oct 19 14:29:48.863251 kernel: kauditd_printk_skb: 63 callbacks suppressed Oct 19 14:29:48.863375 kernel: audit: type=1130 audit(1792420188.854:149): 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 14:29:48.868136 (udev-worker)[1412]: Network interface NamePolicy= disabled on kernel command line. Oct 19 14:29:48.886514 systemd[1]: Reached target network.target - Network. Oct 19 14:29:48.899429 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 19 14:29:48.908314 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Oct 19 14:29:48.998791 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 19 14:29:49.006000 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 14:29:49.015745 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 19 14:29:49.018049 kernel: audit: type=1130 audit(1792420189.006:150): 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 14:29:49.022319 systemd-networkd[1405]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 19 14:29:49.026411 systemd-networkd[1405]: eth0: Link UP Oct 19 14:29:49.026785 systemd-networkd[1405]: eth0: Gained carrier Oct 19 14:29:49.037808 systemd-networkd[1405]: eth0: DHCPv4 address 172.31.29.119/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 19 14:29:49.222079 kernel: vmclock AMZNC10C:00: vmclock0: registered miscdev Oct 19 14:29:49.398513 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 19 14:29:49.659068 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Oct 19 14:29:49.679153 systemd-vconsole-setup[1471]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 19 14:29:49.695482 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 19 14:29:49.699000 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 14:29:49.706301 kernel: audit: type=1130 audit(1792420189.699:151): 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 14:29:49.743725 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Oct 19 14:29:49.763987 kernel: loop4: detected capacity change from 0 to 44497 Oct 19 14:29:49.767324 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 19 14:29:49.778465 kernel: loop4: p1 p2 p3 Oct 19 14:29:49.791814 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:49.791906 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:49.797159 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:49.797274 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:49.797437 (sd-merge)[1547]: device-mapper: reload ioctl on loop4p1-56-verity (254:5) failed: Invalid argument Oct 19 14:29:49.810020 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:49.879100 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 19 14:29:49.882000 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 14:29:49.890461 (sd-merge)[1547]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 19 14:29:49.892527 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Oct 19 14:29:49.892578 kernel: audit: type=1130 audit(1792420189.882:152): 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 14:29:49.904321 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Oct 19 14:29:49.906000 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 14:29:49.917028 kernel: audit: type=1130 audit(1792420189.906:153): 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 14:29:49.922226 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 19 14:29:49.948979 kernel: loop4: detected capacity change from 0 to 404352 Oct 19 14:29:49.962011 kernel: loop4: p1 p2 p3 Oct 19 14:29:49.979779 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:49.979890 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:49.981701 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:49.983046 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:49.983188 systemd-sysext[1559]: device-mapper: reload ioctl on loop4p1-60-verity (254:5) failed: Invalid argument Oct 19 14:29:49.996993 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.051209 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 14:29:50.085996 kernel: loop4: detected capacity change from 0 to 158624 Oct 19 14:29:50.096019 kernel: loop4: p1 p2 p3 Oct 19 14:29:50.109137 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.109265 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:50.109318 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:50.112630 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:50.112767 systemd-sysext[1559]: device-mapper: reload ioctl on loop4p1-65-verity (254:5) failed: Invalid argument Oct 19 14:29:50.120011 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.173549 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 14:29:50.209049 kernel: loop4: detected capacity change from 0 to 305992 Oct 19 14:29:50.217102 kernel: loop4: p1 p2 p3 Oct 19 14:29:50.226635 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.226739 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:50.226806 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:50.228519 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:50.229899 systemd-sysext[1559]: device-mapper: reload ioctl on loop4p1-70-verity (254:5) failed: Invalid argument Oct 19 14:29:50.235054 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.280999 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 14:29:50.293263 systemd-networkd[1405]: eth0: Gained IPv6LL Oct 19 14:29:50.301881 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Oct 19 14:29:50.306000 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 14:29:50.318994 kernel: audit: type=1130 audit(1792420190.306:154): 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 14:29:50.322993 kernel: loop4: detected capacity change from 0 to 404352 Oct 19 14:29:50.324564 systemd[1]: Reached target network-online.target - Network is Online. Oct 19 14:29:50.332995 kernel: loop4: p1 p2 p3 Oct 19 14:29:50.345341 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.345465 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:50.345518 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:50.348158 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:50.348237 (sd-merge)[1584]: device-mapper: reload ioctl on loop4p1-75-verity (254:5) failed: Invalid argument Oct 19 14:29:50.355996 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.407007 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Oct 19 14:29:50.416247 kernel: loop5: detected capacity change from 0 to 158624 Oct 19 14:29:50.425468 kernel: loop5: p1 p2 p3 Oct 19 14:29:50.440625 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.443092 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:50.443181 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:50.444516 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:50.444682 (sd-merge)[1584]: device-mapper: reload ioctl on loop5p1-79-verity (254:6) failed: Invalid argument Oct 19 14:29:50.449998 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.505070 kernel: erofs (device dm-6): mounted with root inode @ nid 39. Oct 19 14:29:50.511093 kernel: loop6: detected capacity change from 0 to 305992 Oct 19 14:29:50.519995 kernel: loop6: p1 p2 p3 Oct 19 14:29:50.530609 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.530702 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 19 14:29:50.530763 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Oct 19 14:29:50.533968 kernel: device-mapper: ioctl: error adding target to table Oct 19 14:29:50.534114 (sd-merge)[1584]: device-mapper: reload ioctl on loop6p1-83-verity (254:7) failed: Invalid argument Oct 19 14:29:50.539976 kernel: device-mapper: verity: sha256 using "sha256-lib" Oct 19 14:29:50.584990 kernel: erofs (device dm-7): mounted with root inode @ nid 39. Oct 19 14:29:50.582480 (sd-merge)[1584]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 19 14:29:50.591277 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 19 14:29:50.593000 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 14:29:50.602080 kernel: audit: type=1130 audit(1792420190.593:155): 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 14:29:50.621593 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 19 14:29:50.724767 systemd-tmpfiles[1607]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 19 14:29:50.725005 systemd-tmpfiles[1607]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 19 14:29:50.726047 systemd-tmpfiles[1607]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 19 14:29:50.729635 systemd-tmpfiles[1607]: ACLs are not supported, ignoring. Oct 19 14:29:50.730044 systemd-tmpfiles[1607]: ACLs are not supported, ignoring. Oct 19 14:29:50.777074 systemd-tmpfiles[1607]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 19 14:29:50.777109 systemd-tmpfiles[1607]: Skipping /boot Oct 19 14:29:50.795834 systemd-tmpfiles[1607]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 19 14:29:50.795862 systemd-tmpfiles[1607]: Skipping /boot Oct 19 14:29:50.828218 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 19 14:29:50.830000 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 14:29:50.838094 kernel: audit: type=1130 audit(1792420190.830:156): 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 14:29:50.839571 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 19 14:29:50.845303 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 19 14:29:50.855758 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 19 14:29:50.872345 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 19 14:29:50.891270 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 19 14:29:50.917000 audit[1615]: AUDIT1127 pid=1615 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 14:29:50.927791 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 19 14:29:50.932029 kernel: audit: type=1127 audit(1792420190.917:157): pid=1615 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 14:29:50.931000 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 14:29:50.944979 kernel: audit: type=1130 audit(1792420190.931:158): 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 14:29:50.966975 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 19 14:29:50.974000 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 14:29:51.043794 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 19 14:29:51.048122 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 14:29:51.046000 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 14:29:51.059000 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 14:29:51.059000 audit[1639]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffc4a6f930 a2=420 a3=0 items=0 ppid=1611 pid=1639 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 14:29:51.059000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 19 14:29:51.060716 augenrules[1639]: No rules Oct 19 14:29:51.062928 systemd[1]: audit-rules.service: Deactivated successfully. Oct 19 14:29:51.063554 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 19 14:29:54.337139 ldconfig[1613]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 19 14:29:54.349891 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 19 14:29:54.356343 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 19 14:29:54.392439 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 19 14:29:54.396444 systemd[1]: Reached target sysinit.target - System Initialization. Oct 19 14:29:54.399607 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 19 14:29:54.403339 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 14:29:54.407332 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 19 14:29:54.410709 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 19 14:29:54.414767 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Oct 19 14:29:54.418676 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Oct 19 14:29:54.421858 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 19 14:29:54.425261 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Oct 19 14:29:54.425355 systemd[1]: Reached target paths.target - Path Units. Oct 19 14:29:54.427994 systemd[1]: Reached target timers.target - Timer Units. Oct 19 14:29:54.432921 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 19 14:29:54.439671 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 19 14:29:54.446849 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 19 14:29:54.454512 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 19 14:29:54.459371 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Oct 19 14:29:54.463795 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 19 14:29:54.468462 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 19 14:29:54.472058 systemd[1]: Reached target sockets.target - Socket Units. Oct 19 14:29:54.475207 systemd[1]: Reached target basic.target - Basic System. Oct 19 14:29:54.477627 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Oct 19 14:29:54.477686 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Oct 19 14:29:54.481170 systemd[1]: Starting containerd.service - containerd container runtime... Oct 19 14:29:54.491150 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Oct 19 14:29:54.504401 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 19 14:29:54.507354 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 19 14:29:54.516392 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 19 14:29:54.524517 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 19 14:29:54.533238 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Oct 19 14:29:54.538213 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 19 14:29:54.549783 systemd[1]: Started ntpd.service - Network Time Service. Oct 19 14:29:54.559399 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 19 14:29:54.575437 systemd[1]: Starting setup-oem.service - Setup OEM... Oct 19 14:29:54.590407 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 19 14:29:54.593205 jq[1653]: false Oct 19 14:29:54.604371 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 19 14:29:54.623339 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 19 14:29:54.630493 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Oct 19 14:29:54.652268 systemd[1]: Starting update-engine.service - Update Engine... Oct 19 14:29:54.661679 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 19 14:29:54.673847 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 19 14:29:54.674627 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 19 14:29:54.723117 extend-filesystems[1654]: Found /dev/nvme0n1p6 Oct 19 14:29:54.730146 extend-filesystems[1654]: Found /dev/nvme0n1p9 Oct 19 14:29:54.735577 extend-filesystems[1654]: Checking size of /dev/nvme0n1p9 Oct 19 14:29:54.744515 motdgen[1682]: /oem/oem-release: line 2: EC2: command not found Oct 19 14:29:54.766600 jq[1667]: true Oct 19 14:29:54.782725 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 19 14:29:54.785529 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 19 14:29:54.879590 coreos-metadata[1651]: Oct 19 14:29:54.879 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 19 14:29:54.881504 systemd[1]: motdgen.service: Deactivated successfully. Oct 19 14:29:54.882140 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 19 14:29:54.886597 coreos-metadata[1651]: Oct 19 14:29:54.884 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Oct 19 14:29:54.886597 coreos-metadata[1651]: Oct 19 14:29:54.885 INFO Fetch successful Oct 19 14:29:54.886597 coreos-metadata[1651]: Oct 19 14:29:54.886 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Oct 19 14:29:54.891618 coreos-metadata[1651]: Oct 19 14:29:54.887 INFO Fetch successful Oct 19 14:29:54.891618 coreos-metadata[1651]: Oct 19 14:29:54.887 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Oct 19 14:29:54.891618 coreos-metadata[1651]: Oct 19 14:29:54.889 INFO Fetch successful Oct 19 14:29:54.891618 coreos-metadata[1651]: Oct 19 14:29:54.889 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Oct 19 14:29:54.891830 extend-filesystems[1654]: Resized partition /dev/nvme0n1p9 Oct 19 14:29:54.897989 coreos-metadata[1651]: Oct 19 14:29:54.895 INFO Fetch successful Oct 19 14:29:54.897989 coreos-metadata[1651]: Oct 19 14:29:54.895 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Oct 19 14:29:54.897989 coreos-metadata[1651]: Oct 19 14:29:54.896 INFO Fetch failed with 404: resource not found Oct 19 14:29:54.897989 coreos-metadata[1651]: Oct 19 14:29:54.896 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Oct 19 14:29:54.898860 coreos-metadata[1651]: Oct 19 14:29:54.898 INFO Fetch successful Oct 19 14:29:54.898860 coreos-metadata[1651]: Oct 19 14:29:54.898 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Oct 19 14:29:54.901016 coreos-metadata[1651]: Oct 19 14:29:54.900 INFO Fetch successful Oct 19 14:29:54.901016 coreos-metadata[1651]: Oct 19 14:29:54.900 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Oct 19 14:29:54.902746 coreos-metadata[1651]: Oct 19 14:29:54.902 INFO Fetch successful Oct 19 14:29:54.902746 coreos-metadata[1651]: Oct 19 14:29:54.902 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Oct 19 14:29:54.907044 coreos-metadata[1651]: Oct 19 14:29:54.906 INFO Fetch successful Oct 19 14:29:54.907044 coreos-metadata[1651]: Oct 19 14:29:54.906 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Oct 19 14:29:54.909311 coreos-metadata[1651]: Oct 19 14:29:54.907 INFO Fetch successful Oct 19 14:29:54.924007 jq[1684]: true Oct 19 14:29:54.936550 dbus-daemon[1652]: [system] SELinux support is enabled Oct 19 14:29:54.937097 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 19 14:29:54.941523 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 14:29:54.941587 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 19 14:29:54.946474 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 14:29:54.946519 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 19 14:29:54.957548 ntpd[1656]: ntpd 4.2.8p18@1.4062-o Mon Oct 19 12:08:39 UTC 2026 (1): Starting Oct 19 14:29:54.958932 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: ntpd 4.2.8p18@1.4062-o Mon Oct 19 12:08:39 UTC 2026 (1): Starting Oct 19 14:29:54.958932 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 19 14:29:54.958932 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: ---------------------------------------------------- Oct 19 14:29:54.958932 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: ntp-4 is maintained by Network Time Foundation, Oct 19 14:29:54.958932 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 19 14:29:54.958932 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: corporation. Support and training for ntp-4 are Oct 19 14:29:54.958932 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: available at https://www.nwtime.org/support Oct 19 14:29:54.958932 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: ---------------------------------------------------- Oct 19 14:29:54.957718 ntpd[1656]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 19 14:29:54.957741 ntpd[1656]: ---------------------------------------------------- Oct 19 14:29:54.957760 ntpd[1656]: ntp-4 is maintained by Network Time Foundation, Oct 19 14:29:54.957778 ntpd[1656]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 19 14:29:54.957795 ntpd[1656]: corporation. Support and training for ntp-4 are Oct 19 14:29:54.957813 ntpd[1656]: available at https://www.nwtime.org/support Oct 19 14:29:54.957831 ntpd[1656]: ---------------------------------------------------- Oct 19 14:29:54.965204 dbus-daemon[1652]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1405 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Oct 19 14:29:54.974468 extend-filesystems[1714]: resize2fs 1.47.4 (6-Mar-2025) Oct 19 14:29:54.982685 ntpd[1656]: proto: precision = 0.096 usec (-23) Oct 19 14:29:54.993623 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: proto: precision = 0.096 usec (-23) Oct 19 14:29:54.993623 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: basedate set to 2026-10-07 Oct 19 14:29:54.993623 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: gps base set to 2026-10-11 (week 2440) Oct 19 14:29:54.993623 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: Listen and drop on 0 v6wildcard [::]:123 Oct 19 14:29:54.993623 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 19 14:29:54.993623 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: Listen normally on 2 lo 127.0.0.1:123 Oct 19 14:29:54.993623 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: Listen normally on 3 eth0 172.31.29.119:123 Oct 19 14:29:54.993623 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: Listen normally on 4 lo [::1]:123 Oct 19 14:29:54.993623 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: Listen normally on 5 eth0 [fe80::4ff:c1ff:fe88:ef97%2]:123 Oct 19 14:29:54.993623 ntpd[1656]: 19 Oct 14:29:54 ntpd[1656]: Listening on routing socket on fd #22 for interface updates Oct 19 14:29:54.983121 ntpd[1656]: basedate set to 2026-10-07 Oct 19 14:29:54.983154 ntpd[1656]: gps base set to 2026-10-11 (week 2440) Oct 19 14:29:54.983360 ntpd[1656]: Listen and drop on 0 v6wildcard [::]:123 Oct 19 14:29:54.983414 ntpd[1656]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 19 14:29:54.990465 dbus-daemon[1652]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 19 14:29:54.991859 ntpd[1656]: Listen normally on 2 lo 127.0.0.1:123 Oct 19 14:29:54.991923 ntpd[1656]: Listen normally on 3 eth0 172.31.29.119:123 Oct 19 14:29:54.992020 ntpd[1656]: Listen normally on 4 lo [::1]:123 Oct 19 14:29:54.992075 ntpd[1656]: Listen normally on 5 eth0 [fe80::4ff:c1ff:fe88:ef97%2]:123 Oct 19 14:29:54.992130 ntpd[1656]: Listening on routing socket on fd #22 for interface updates Oct 19 14:29:55.015218 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 1617920 to 2604027 blocks Oct 19 14:29:55.010840 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Oct 19 14:29:55.050713 ntpd[1656]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 14:29:55.070789 ntpd[1656]: 19 Oct 14:29:55 ntpd[1656]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 14:29:55.070789 ntpd[1656]: 19 Oct 14:29:55 ntpd[1656]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 14:29:55.070940 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 2604027 Oct 19 14:29:55.050774 ntpd[1656]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 19 14:29:55.071181 update_engine[1665]: I20261019 14:29:55.064465 1665 main.cc:92] Flatcar Update Engine starting Oct 19 14:29:55.085339 extend-filesystems[1714]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Oct 19 14:29:55.085339 extend-filesystems[1714]: old_desc_blocks = 1, new_desc_blocks = 2 Oct 19 14:29:55.085339 extend-filesystems[1714]: The filesystem on /dev/nvme0n1p9 is now 2604027 (4k) blocks long. Oct 19 14:29:55.077204 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 19 14:29:55.122888 extend-filesystems[1654]: Resized filesystem in /dev/nvme0n1p9 Oct 19 14:29:55.077904 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 19 14:29:55.105078 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 19 14:29:55.142318 systemd[1]: Started update-engine.service - Update Engine. Oct 19 14:29:55.149476 update_engine[1665]: I20261019 14:29:55.142329 1665 update_check_scheduler.cc:74] Next update check in 2m46s Oct 19 14:29:55.160670 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 19 14:29:55.168020 systemd[1]: Finished setup-oem.service - Setup OEM. Oct 19 14:29:55.175308 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Oct 19 14:29:55.184904 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Oct 19 14:29:55.195388 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Oct 19 14:29:55.250608 (etcd-wrapper)[1736]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Oct 19 14:29:55.423704 bash[1750]: Updated "/home/core/.ssh/authorized_keys" Oct 19 14:29:55.428834 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 19 14:29:55.444153 systemd[1]: Starting sshkeys.service... Oct 19 14:29:55.506130 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Oct 19 14:29:55.517302 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Oct 19 14:29:55.542488 sshd_keygen[1689]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Oct 19 14:29:55.590024 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Oct 19 14:29:55.602432 dbus-daemon[1652]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 19 14:29:55.604972 systemd-logind[1664]: Watching system buttons on /dev/input/event0 (Power Button) Oct 19 14:29:55.605035 systemd-logind[1664]: Watching system buttons on /dev/input/event1 (Sleep Button) Oct 19 14:29:55.609380 systemd-logind[1664]: New seat seat0. Oct 19 14:29:55.616698 systemd[1]: Started systemd-logind.service - User Login Management. Oct 19 14:29:55.633543 dbus-daemon[1652]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1719 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Oct 19 14:29:55.654325 systemd[1]: Starting polkit.service - Authorization Manager... Oct 19 14:29:55.790682 amazon-ssm-agent[1734]: Initializing new seelog logger Oct 19 14:29:55.800934 amazon-ssm-agent[1734]: New Seelog Logger Creation Complete Oct 19 14:29:55.800934 amazon-ssm-agent[1734]: 2026/10/19 14:29:55 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 14:29:55.800934 amazon-ssm-agent[1734]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 14:29:55.800934 amazon-ssm-agent[1734]: 2026/10/19 14:29:55 processing appconfig overrides Oct 19 14:29:55.800934 amazon-ssm-agent[1734]: 2026/10/19 14:29:55 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 14:29:55.800934 amazon-ssm-agent[1734]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 14:29:55.800934 amazon-ssm-agent[1734]: 2026/10/19 14:29:55 processing appconfig overrides Oct 19 14:29:55.800934 amazon-ssm-agent[1734]: 2026/10/19 14:29:55 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 14:29:55.800934 amazon-ssm-agent[1734]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 14:29:55.800934 amazon-ssm-agent[1734]: 2026/10/19 14:29:55 processing appconfig overrides Oct 19 14:29:55.804768 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 19 14:29:55.809878 amazon-ssm-agent[1734]: 2026-10-19 14:29:55.7927 INFO Proxy environment variables: Oct 19 14:29:55.812936 locksmithd[1730]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 19 14:29:55.830331 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 19 14:29:55.849990 amazon-ssm-agent[1734]: 2026/10/19 14:29:55 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 14:29:55.849990 amazon-ssm-agent[1734]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 14:29:55.849990 amazon-ssm-agent[1734]: 2026/10/19 14:29:55 processing appconfig overrides Oct 19 14:29:55.854237 coreos-metadata[1754]: Oct 19 14:29:55.854 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 19 14:29:55.857277 coreos-metadata[1754]: Oct 19 14:29:55.855 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Oct 19 14:29:55.864914 coreos-metadata[1754]: Oct 19 14:29:55.861 INFO Fetch successful Oct 19 14:29:55.864914 coreos-metadata[1754]: Oct 19 14:29:55.864 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Oct 19 14:29:55.864914 coreos-metadata[1754]: Oct 19 14:29:55.864 INFO Fetch successful Oct 19 14:29:55.869218 unknown[1754]: wrote ssh authorized keys file for user: core Oct 19 14:29:55.910272 amazon-ssm-agent[1734]: 2026-10-19 14:29:55.7950 INFO https_proxy: Oct 19 14:29:55.923681 systemd[1]: issuegen.service: Deactivated successfully. Oct 19 14:29:55.924314 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 19 14:29:55.941368 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 19 14:29:55.970937 update-ssh-keys[1803]: Updated "/home/core/.ssh/authorized_keys" Oct 19 14:29:55.973171 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Oct 19 14:29:56.005879 systemd[1]: Finished sshkeys.service. Oct 19 14:29:56.017250 amazon-ssm-agent[1734]: 2026-10-19 14:29:55.7950 INFO http_proxy: Oct 19 14:29:56.041602 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 19 14:29:56.056646 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 19 14:29:56.064009 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 19 14:29:56.068247 systemd[1]: Reached target getty.target - Login Prompts. Oct 19 14:29:56.114995 amazon-ssm-agent[1734]: 2026-10-19 14:29:55.7950 INFO no_proxy: Oct 19 14:29:56.168720 polkitd[1768]: Started polkitd version 126 Oct 19 14:29:56.203437 polkitd[1768]: Loading rules from directory /etc/polkit-1/rules.d Oct 19 14:29:56.203744 polkitd[1768]: Loading rules from directory /run/polkit-1/rules.d Oct 19 14:29:56.203898 polkitd[1768]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Oct 19 14:29:56.204330 polkitd[1768]: Loading rules from directory /usr/local/share/polkit-1/rules.d Oct 19 14:29:56.204466 polkitd[1768]: 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 14:29:56.204612 polkitd[1768]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 19 14:29:56.213164 polkitd[1768]: Finished loading, compiling and executing 5 rules Oct 19 14:29:56.213844 systemd[1]: Started polkit.service - Authorization Manager. Oct 19 14:29:56.217600 amazon-ssm-agent[1734]: 2026-10-19 14:29:55.7952 INFO Checking if agent identity type OnPrem can be assumed Oct 19 14:29:56.223290 dbus-daemon[1652]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 19 14:29:56.229330 polkitd[1768]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 19 14:29:56.292141 systemd-hostnamed[1719]: Hostname set to (transient) Oct 19 14:29:56.292323 systemd-resolved[1368]: System hostname changed to 'ip-172-31-29-119'. Oct 19 14:29:56.321043 amazon-ssm-agent[1734]: 2026-10-19 14:29:55.7953 INFO Checking if agent identity type EC2 can be assumed Oct 19 14:29:56.419301 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.1141 INFO Agent will take identity from EC2 Oct 19 14:29:56.520246 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.1278 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.3.0.0 Oct 19 14:29:56.623715 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.1279 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Oct 19 14:29:56.715029 containerd[1700]: time="2026-10-19T14:29:56Z" 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 14:29:56.715627 containerd[1700]: time="2026-10-19T14:29:56Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="23.016µs" Oct 19 14:29:56.719850 containerd[1700]: time="2026-10-19T14:29:56.718412931Z" level=info msg="starting containerd" revision=1294c24a7da8e5a793ed378161673abe94118892 version=v2.3.5 Oct 19 14:29:56.719850 containerd[1700]: time="2026-10-19T14:29:56.719730723Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 19 14:29:56.720254 containerd[1700]: time="2026-10-19T14:29:56.720202191Z" 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 14:29:56.720313 containerd[1700]: time="2026-10-19T14:29:56.720254511Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 19 14:29:56.720313 containerd[1700]: time="2026-10-19T14:29:56.720296607Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 19 14:29:56.720600 containerd[1700]: time="2026-10-19T14:29:56.720554667Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 19 14:29:56.720655 containerd[1700]: time="2026-10-19T14:29:56.720599799Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 19 14:29:56.720741 containerd[1700]: time="2026-10-19T14:29:56.720701691Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Oct 19 14:29:56.720810 containerd[1700]: time="2026-10-19T14:29:56.720753663Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 19 14:29:56.721983 containerd[1700]: time="2026-10-19T14:29:56.720901791Z" 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 14:29:56.721983 containerd[1700]: time="2026-10-19T14:29:56.720930735Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 19 14:29:56.721983 containerd[1700]: time="2026-10-19T14:29:56.721344099Z" 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 14:29:56.721983 containerd[1700]: time="2026-10-19T14:29:56.721395051Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 19 14:29:56.721983 containerd[1700]: time="2026-10-19T14:29:56.721433847Z" 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 14:29:56.721983 containerd[1700]: time="2026-10-19T14:29:56.721459371Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 19 14:29:56.721983 containerd[1700]: time="2026-10-19T14:29:56.721779459Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 19 14:29:56.722276 containerd[1700]: time="2026-10-19T14:29:56.721936071Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 19 14:29:56.722845 containerd[1700]: time="2026-10-19T14:29:56.722768763Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 19 14:29:56.722995 containerd[1700]: time="2026-10-19T14:29:56.722915691Z" 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 14:29:56.722995 containerd[1700]: time="2026-10-19T14:29:56.722965179Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 19 14:29:56.724165 containerd[1700]: time="2026-10-19T14:29:56.724080351Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 19 14:29:56.724361 containerd[1700]: time="2026-10-19T14:29:56.724306899Z" level=info msg="metadata content store policy set" policy=shared Oct 19 14:29:56.724820 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.1279 INFO [amazon-ssm-agent] Starting Core Agent Oct 19 14:29:56.732856 containerd[1700]: time="2026-10-19T14:29:56.732760155Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.732887163Z" level=info msg="loading plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.732917811Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.732969243Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733005183Z" 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 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733029351Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733054095Z" 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 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733074171Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733275231Z" level=info msg="built-in NRI default validator is disabled" Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733298847Z" level=info msg="runtime interface created" Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733320099Z" level=info msg="created NRI interface" Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733342347Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733366539Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733399239Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 19 14:29:56.733805 containerd[1700]: time="2026-10-19T14:29:56.733424487Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 19 14:29:56.778229 containerd[1700]: time="2026-10-19T14:29:56.778160319Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Oct 19 14:29:56.779796 containerd[1700]: time="2026-10-19T14:29:56.779726019Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 19 14:29:56.779894 containerd[1700]: time="2026-10-19T14:29:56.779803167Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 19 14:29:56.779894 containerd[1700]: time="2026-10-19T14:29:56.779832483Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 19 14:29:56.779894 containerd[1700]: time="2026-10-19T14:29:56.779859267Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 19 14:29:56.779894 containerd[1700]: time="2026-10-19T14:29:56.779882463Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 19 14:29:56.780116 containerd[1700]: time="2026-10-19T14:29:56.779904975Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 19 14:29:56.780116 containerd[1700]: time="2026-10-19T14:29:56.779928231Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 19 14:29:56.780116 containerd[1700]: time="2026-10-19T14:29:56.779986719Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 19 14:29:56.780260 containerd[1700]: time="2026-10-19T14:29:56.780238167Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 19 14:29:56.780304 containerd[1700]: time="2026-10-19T14:29:56.780274239Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 19 14:29:56.780357 containerd[1700]: time="2026-10-19T14:29:56.780301479Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 19 14:29:56.780357 containerd[1700]: time="2026-10-19T14:29:56.780323823Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 19 14:29:56.780357 containerd[1700]: time="2026-10-19T14:29:56.780347655Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 19 14:29:56.780497 containerd[1700]: time="2026-10-19T14:29:56.780369087Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 19 14:29:56.780497 containerd[1700]: time="2026-10-19T14:29:56.780396039Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 19 14:29:56.780497 containerd[1700]: time="2026-10-19T14:29:56.780422043Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 19 14:29:56.780497 containerd[1700]: time="2026-10-19T14:29:56.780449271Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 19 14:29:56.780497 containerd[1700]: time="2026-10-19T14:29:56.780476871Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Oct 19 14:29:56.780678 containerd[1700]: time="2026-10-19T14:29:56.780500919Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 19 14:29:56.780678 containerd[1700]: time="2026-10-19T14:29:56.780527571Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 19 14:29:56.780678 containerd[1700]: time="2026-10-19T14:29:56.780551751Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 19 14:29:56.780678 containerd[1700]: time="2026-10-19T14:29:56.780629691Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 19 14:29:56.790999 containerd[1700]: time="2026-10-19T14:29:56.784175523Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 19 14:29:56.790999 containerd[1700]: time="2026-10-19T14:29:56.790826835Z" level=info msg="Start snapshots syncer" Oct 19 14:29:56.793461 containerd[1700]: time="2026-10-19T14:29:56.792575823Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 19 14:29:56.793461 containerd[1700]: time="2026-10-19T14:29:56.793219599Z" 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 14:29:56.793709 containerd[1700]: time="2026-10-19T14:29:56.793317315Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 19 14:29:56.795967 containerd[1700]: time="2026-10-19T14:29:56.795317979Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 19 14:29:56.796251 containerd[1700]: time="2026-10-19T14:29:56.796195743Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 19 14:29:56.796311 containerd[1700]: time="2026-10-19T14:29:56.796265907Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 19 14:29:56.796311 containerd[1700]: time="2026-10-19T14:29:56.796292367Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 19 14:29:56.796390 containerd[1700]: time="2026-10-19T14:29:56.796320567Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 19 14:29:56.796390 containerd[1700]: time="2026-10-19T14:29:56.796348479Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 19 14:29:56.796390 containerd[1700]: time="2026-10-19T14:29:56.796373475Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 19 14:29:56.796520 containerd[1700]: time="2026-10-19T14:29:56.796396119Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 19 14:29:56.796520 containerd[1700]: time="2026-10-19T14:29:56.796422651Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 19 14:29:56.796520 containerd[1700]: time="2026-10-19T14:29:56.796444851Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 19 14:29:56.796520 containerd[1700]: time="2026-10-19T14:29:56.796470231Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 19 14:29:56.796520 containerd[1700]: time="2026-10-19T14:29:56.796506039Z" level=info msg="Connect containerd service" Oct 19 14:29:56.796703 containerd[1700]: time="2026-10-19T14:29:56.796562367Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 19 14:29:56.801971 containerd[1700]: time="2026-10-19T14:29:56.799160751Z" 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 14:29:56.825985 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.1279 INFO [amazon-ssm-agent] Registrar detected. Attempting registration Oct 19 14:29:56.926125 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.1279 INFO [Registrar] Starting registrar module Oct 19 14:29:56.999847 amazon-ssm-agent[1734]: 2026/10/19 14:29:56 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 14:29:56.999847 amazon-ssm-agent[1734]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 19 14:29:57.000067 amazon-ssm-agent[1734]: 2026/10/19 14:29:57 processing appconfig overrides Oct 19 14:29:57.026181 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.1305 INFO [EC2Identity] Checking disk for registration info Oct 19 14:29:57.027054 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.1306 INFO [EC2Identity] No registration info found for ec2 instance, attempting registration Oct 19 14:29:57.027054 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.1306 INFO [EC2Identity] Generating registration keypair Oct 19 14:29:57.027054 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.9599 INFO [EC2Identity] Checking write access before registering Oct 19 14:29:57.027054 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.9606 INFO [EC2Identity] Registering EC2 instance with Systems Manager Oct 19 14:29:57.027054 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.9995 INFO [EC2Identity] EC2 registration was successful. Oct 19 14:29:57.027054 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.9996 INFO [amazon-ssm-agent] Registration attempted. Resuming core agent startup. Oct 19 14:29:57.027054 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.9997 INFO [CredentialRefresher] credentialRefresher has started Oct 19 14:29:57.027054 amazon-ssm-agent[1734]: 2026-10-19 14:29:56.9997 INFO [CredentialRefresher] Starting credentials refresher loop Oct 19 14:29:57.027054 amazon-ssm-agent[1734]: 2026-10-19 14:29:57.0263 INFO EC2RoleProvider Successfully connected with instance profile role credentials Oct 19 14:29:57.027054 amazon-ssm-agent[1734]: 2026-10-19 14:29:57.0266 INFO [CredentialRefresher] Credentials ready Oct 19 14:29:57.125095 amazon-ssm-agent[1734]: 2026-10-19 14:29:57.0268 INFO [CredentialRefresher] Next credential rotation will be in 29.9999923189 minutes Oct 19 14:29:57.439539 containerd[1700]: time="2026-10-19T14:29:57.439466270Z" level=info msg="loading plugin" id=io.containerd.server.v1.ttrpc type=io.containerd.server.v1 Oct 19 14:29:57.439680 containerd[1700]: time="2026-10-19T14:29:57.439608242Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 19 14:29:57.439732 containerd[1700]: time="2026-10-19T14:29:57.439687322Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-prometheus type=io.containerd.metrics.v1 Oct 19 14:29:57.439779 containerd[1700]: time="2026-10-19T14:29:57.439758050Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-otel type=io.containerd.metrics.v1 Oct 19 14:29:57.439824 containerd[1700]: time="2026-10-19T14:29:57.439796246Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc type=io.containerd.server.v1 Oct 19 14:29:57.440541 containerd[1700]: time="2026-10-19T14:29:57.440013014Z" level=info msg="Start subscribing containerd event" Oct 19 14:29:57.440541 containerd[1700]: time="2026-10-19T14:29:57.440095646Z" level=info msg="Start stats collector" Oct 19 14:29:57.440541 containerd[1700]: time="2026-10-19T14:29:57.440114306Z" level=info msg="Start recovering state" Oct 19 14:29:57.440541 containerd[1700]: time="2026-10-19T14:29:57.440244710Z" level=info msg="Start event monitor" Oct 19 14:29:57.440541 containerd[1700]: time="2026-10-19T14:29:57.440269010Z" level=info msg="Start cni network conf syncer for default" Oct 19 14:29:57.440541 containerd[1700]: time="2026-10-19T14:29:57.440290754Z" level=info msg="Start streaming server" Oct 19 14:29:57.440541 containerd[1700]: time="2026-10-19T14:29:57.440309234Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 19 14:29:57.440541 containerd[1700]: time="2026-10-19T14:29:57.440327330Z" level=info msg="runtime interface starting up..." Oct 19 14:29:57.440541 containerd[1700]: time="2026-10-19T14:29:57.440347466Z" level=info msg="starting plugins..." Oct 19 14:29:57.440541 containerd[1700]: time="2026-10-19T14:29:57.440376002Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 19 14:29:57.457001 containerd[1700]: time="2026-10-19T14:29:57.456881042Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Oct 19 14:29:57.457001 containerd[1700]: time="2026-10-19T14:29:57.456985898Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Oct 19 14:29:57.457178 containerd[1700]: time="2026-10-19T14:29:57.457013966Z" level=info msg="loading plugin" id=io.containerd.http.v1.pprof type=io.containerd.http.v1 Oct 19 14:29:57.457652 containerd[1700]: time="2026-10-19T14:29:57.457569566Z" level=info msg="loading plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Oct 19 14:29:57.457652 containerd[1700]: time="2026-10-19T14:29:57.457636622Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Oct 19 14:29:57.457862 containerd[1700]: time="2026-10-19T14:29:57.457822142Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 19 14:29:57.457922 containerd[1700]: time="2026-10-19T14:29:57.457867454Z" level=info msg="starting GRPC server" address=/run/containerd/containerd.sock gid=0 uid=0 Oct 19 14:29:57.458035 containerd[1700]: time="2026-10-19T14:29:57.457999550Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 19 14:29:57.458185 containerd[1700]: time="2026-10-19T14:29:57.458135354Z" level=info msg="containerd successfully booted in 0.751608s" Oct 19 14:29:57.458544 systemd[1]: Started containerd.service - containerd container runtime. Oct 19 14:29:57.466349 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 19 14:29:57.485868 (dockerd)[1947]: 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 14:29:58.056525 amazon-ssm-agent[1734]: 2026-10-19 14:29:58.0563 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Oct 19 14:29:58.157761 amazon-ssm-agent[1734]: 2026-10-19 14:29:58.0581 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:1951) started Oct 19 14:29:58.258465 amazon-ssm-agent[1734]: 2026-10-19 14:29:58.0581 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Oct 19 14:30:00.822046 dockerd[1947]: time="2026-10-19T14:30:00.821901859Z" level=info msg="Starting up" Oct 19 14:30:00.830105 dockerd[1947]: time="2026-10-19T14:30:00.829886479Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 19 14:30:00.831738 dockerd[1947]: time="2026-10-19T14:30:00.831685447Z" level=info msg="CDI directory does not exist, skipping" dir=/var/run/cdi Oct 19 14:30:00.831738 dockerd[1947]: time="2026-10-19T14:30:00.831728623Z" level=info msg="CDI directory does not exist, skipping" dir=/etc/cdi Oct 19 14:30:00.859981 dockerd[1947]: time="2026-10-19T14:30:00.858718783Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 19 14:30:00.861715 dockerd[1947]: time="2026-10-19T14:30:00.861633955Z" level=warning msg="failed check for fsverity support" error="enable fsverity failed: operation not supported" path=/var/lib/docker/plugins/storage Oct 19 14:30:00.882803 dockerd[1947]: time="2026-10-19T14:30:00.882757447Z" level=info msg="Loading containers: start." Oct 19 14:30:00.883066 dockerd[1947]: time="2026-10-19T14:30:00.883030255Z" level=info msg="NRI is disabled" Oct 19 14:30:00.883126 dockerd[1947]: time="2026-10-19T14:30:00.883062175Z" level=info msg="Starting daemon with containerd snapshotter integration enabled" Oct 19 14:30:00.914897 dockerd[1947]: time="2026-10-19T14:30:00.914823859Z" level=info msg="Restoring containers: start." Oct 19 14:30:01.041343 dockerd[1947]: time="2026-10-19T14:30:01.041069872Z" 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 14:30:01.049751 dockerd[1947]: time="2026-10-19T14:30:01.049681852Z" 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 14:30:01.163527 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 19 14:30:01.169271 systemd[1]: Started sshd@0-1-172.31.29.119:22-98.64.94.113:33190.service - OpenSSH per-connection server daemon (98.64.94.113:33190). Oct 19 14:30:01.536986 kernel: Initializing XFRM netlink socket Oct 19 14:30:01.583244 (udev-worker)[1987]: Network interface NamePolicy= disabled on kernel command line. Oct 19 14:30:01.650193 systemd-networkd[1405]: docker0: Link UP Oct 19 14:30:01.664232 dockerd[1947]: time="2026-10-19T14:30:01.664154575Z" level=info msg="Loading containers: done." Oct 19 14:30:01.688498 dockerd[1947]: time="2026-10-19T14:30:01.688442623Z" level=info msg="Docker daemon" commit=3ce5872b7950c63ba2ffbc5123101019ff3e6682 containerd-snapshotter=true storage-driver=overlayfs version=29.8.0 Oct 19 14:30:01.688713 dockerd[1947]: time="2026-10-19T14:30:01.688672351Z" level=info msg="Initializing buildkit" Oct 19 14:30:02.121412 systemd-resolved[1368]: Clock change detected. Flushing caches. Oct 19 14:30:02.319254 sshd[2036]: Accepted publickey for core from 98.64.94.113 port 33190 ssh2: RSA SHA256:8hGnqhN3mn1VPS76dNbV39xgqnqKPoX7pTZhFGBu69A Oct 19 14:30:02.323532 sshd-session[2036]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 14:30:02.340205 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 19 14:30:02.343899 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 19 14:30:02.373418 systemd-logind[1664]: New session '1' of user 'core' with class 'user' and type 'tty'. Oct 19 14:30:02.401920 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 19 14:30:02.410425 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 19 14:30:02.434597 (systemd)[2161]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Oct 19 14:30:02.440208 systemd-logind[1664]: New session '2' of user 'core' with class 'manager-early' and type 'unspecified'. Oct 19 14:30:02.962851 dockerd[1947]: time="2026-10-19T14:30:02.962779016Z" level=info msg="Completed buildkit initialization" Oct 19 14:30:02.975199 dockerd[1947]: time="2026-10-19T14:30:02.975115076Z" level=info msg="Daemon has completed initialization" Oct 19 14:30:02.975340 dockerd[1947]: time="2026-10-19T14:30:02.975239156Z" level=info msg="API listen on /run/docker.sock" Oct 19 14:30:02.976068 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 19 14:30:02.983256 etcd-wrapper[1749]: Error response from daemon: No such container: etcd-member Oct 19 14:30:03.031622 systemd[2161]: Queued start job for default target default.target. Oct 19 14:30:03.037122 systemd[2161]: Created slice app.slice - User Application Slice. Oct 19 14:30:03.037595 systemd[2161]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Oct 19 14:30:03.037643 systemd[2161]: Reached target machines.target - Virtual Machines and Containers. Oct 19 14:30:03.037787 systemd[2161]: Reached target paths.target - Paths. Oct 19 14:30:03.037866 systemd[2161]: Reached target timers.target - Timers. Oct 19 14:30:03.041410 systemd[2161]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 19 14:30:03.046419 systemd[2161]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 19 14:30:03.047089 systemd[2161]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 19 14:30:03.049456 systemd[2161]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 19 14:30:03.050257 systemd[2161]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 19 14:30:03.053562 systemd[2161]: Listening on systemd-storage-fs.socket - Simple File System Backed Storage Provider. Oct 19 14:30:03.056792 systemd[2161]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Oct 19 14:30:03.072637 systemd[2161]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 19 14:30:03.075761 systemd[2161]: Reached target sockets.target - Sockets. Oct 19 14:30:03.090439 systemd[2161]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Oct 19 14:30:03.090785 systemd[2161]: Reached target basic.target - Basic System. Oct 19 14:30:03.091037 systemd[2161]: Reached target default.target - Main User Target. Oct 19 14:30:03.091519 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 19 14:30:03.092880 systemd[2161]: Startup finished in 639ms. Oct 19 14:30:03.099997 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 19 14:30:03.136032 etcd-wrapper[2190]: Unable to find image 'quay.io/coreos/etcd:v3.5.24' locally Oct 19 14:30:03.593841 systemd[1]: Started sshd@1-2-172.31.29.119:22-98.64.94.113:33196.service - OpenSSH per-connection server daemon (98.64.94.113:33196). Oct 19 14:30:03.653420 etcd-wrapper[2190]: v3.5.24: Pulling from coreos/etcd Oct 19 14:30:04.055083 etcd-wrapper[2190]: 2ae710cd8bfe: Pulling fs layer Oct 19 14:30:04.055439 etcd-wrapper[2190]: 564a832d7b24: Pulling fs layer Oct 19 14:30:04.055706 etcd-wrapper[2190]: b5e058125d2e: Pulling fs layer Oct 19 14:30:04.055706 etcd-wrapper[2190]: afae8b8aae79: Pulling fs layer Oct 19 14:30:04.055706 etcd-wrapper[2190]: 307c1adadb60: Pulling fs layer Oct 19 14:30:04.056239 etcd-wrapper[2190]: d462aa345367: Pulling fs layer Oct 19 14:30:04.056239 etcd-wrapper[2190]: 0f8b424aa0b9: Pulling fs layer Oct 19 14:30:04.056239 etcd-wrapper[2190]: d7c7ccc36d88: Pulling fs layer Oct 19 14:30:04.056239 etcd-wrapper[2190]: d557676654e5: Pulling fs layer Oct 19 14:30:04.056239 etcd-wrapper[2190]: c8022d07192e: Pulling fs layer Oct 19 14:30:04.056239 etcd-wrapper[2190]: d858cbc252ad: Pulling fs layer Oct 19 14:30:04.057097 etcd-wrapper[2190]: 1069fc2daed1: Pulling fs layer Oct 19 14:30:04.057097 etcd-wrapper[2190]: b40161cd83fc: Pulling fs layer Oct 19 14:30:04.057097 etcd-wrapper[2190]: d10f96ed9607: Pulling fs layer Oct 19 14:30:04.057097 etcd-wrapper[2190]: 5318d93a3a65: Pulling fs layer Oct 19 14:30:04.057097 etcd-wrapper[2190]: d28d4aa02c9a: Pulling fs layer Oct 19 14:30:04.255815 etcd-wrapper[2190]: b40161cd83fc: Download complete Oct 19 14:30:04.448917 sshd[2201]: Accepted publickey for core from 98.64.94.113 port 33196 ssh2: RSA SHA256:8hGnqhN3mn1VPS76dNbV39xgqnqKPoX7pTZhFGBu69A Oct 19 14:30:04.453084 sshd-session[2201]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 14:30:04.461179 etcd-wrapper[2190]: d462aa345367: Download complete Oct 19 14:30:04.471320 systemd-logind[1664]: New session '3' of user 'core' with class 'user' and type 'tty'. Oct 19 14:30:04.474599 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 19 14:30:04.555975 etcd-wrapper[2190]: 564a832d7b24: Download complete Oct 19 14:30:04.557349 etcd-wrapper[2190]: 0f8b424aa0b9: Download complete Oct 19 14:30:04.655698 etcd-wrapper[2190]: 2ae710cd8bfe: Download complete Oct 19 14:30:04.656509 etcd-wrapper[2190]: b5e058125d2e: Download complete Oct 19 14:30:04.657494 etcd-wrapper[2190]: d557676654e5: Download complete Oct 19 14:30:04.754738 etcd-wrapper[2190]: afae8b8aae79: Download complete Oct 19 14:30:04.755458 etcd-wrapper[2190]: c8022d07192e: Download complete Oct 19 14:30:04.855170 etcd-wrapper[2190]: 307c1adadb60: Download complete Oct 19 14:30:04.923409 sshd[2205]: Connection closed by 98.64.94.113 port 33196 Oct 19 14:30:04.925492 sshd-session[2201]: pam_unix(sshd:session): session closed for user core Oct 19 14:30:04.931180 systemd[1]: sshd@1-2-172.31.29.119:22-98.64.94.113:33196.service: Deactivated successfully. Oct 19 14:30:04.935031 systemd[1]: session-3.scope: Deactivated successfully. Oct 19 14:30:04.936931 systemd-logind[1664]: Session 3 logged out. Waiting for processes to exit. Oct 19 14:30:04.939864 systemd-logind[1664]: Removed session 3. Oct 19 14:30:04.954441 etcd-wrapper[2190]: d7c7ccc36d88: Download complete Oct 19 14:30:04.955103 etcd-wrapper[2190]: 1069fc2daed1: Download complete Oct 19 14:30:05.046868 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1898024161.mount: Deactivated successfully. Oct 19 14:30:05.055042 etcd-wrapper[2190]: d858cbc252ad: Download complete Oct 19 14:30:05.055297 etcd-wrapper[2190]: d10f96ed9607: Download complete Oct 19 14:30:05.063179 etcd-wrapper[2190]: d10f96ed9607: Pull complete Oct 19 14:30:05.096828 systemd[1]: Started sshd@2-4097-172.31.29.119:22-98.64.94.113:33198.service - OpenSSH per-connection server daemon (98.64.94.113:33198). Oct 19 14:30:05.158939 etcd-wrapper[2190]: 5318d93a3a65: Download complete Oct 19 14:30:05.185918 etcd-wrapper[2190]: 2ae710cd8bfe: Pull complete Oct 19 14:30:05.255325 etcd-wrapper[2190]: d28d4aa02c9a: Download complete Oct 19 14:30:05.655745 etcd-wrapper[2190]: d462aa345367: Pull complete Oct 19 14:30:05.658878 etcd-wrapper[2190]: 0f8b424aa0b9: Pull complete Oct 19 14:30:05.659881 etcd-wrapper[2190]: d557676654e5: Pull complete Oct 19 14:30:05.662361 etcd-wrapper[2190]: c8022d07192e: Pull complete Oct 19 14:30:05.754348 etcd-wrapper[2190]: b40161cd83fc: Pull complete Oct 19 14:30:05.757856 etcd-wrapper[2190]: 307c1adadb60: Pull complete Oct 19 14:30:05.759438 etcd-wrapper[2190]: 1069fc2daed1: Pull complete Oct 19 14:30:05.760673 etcd-wrapper[2190]: d858cbc252ad: Pull complete Oct 19 14:30:05.762159 etcd-wrapper[2190]: 5318d93a3a65: Pull complete Oct 19 14:30:05.979726 sshd[2224]: Accepted publickey for core from 98.64.94.113 port 33198 ssh2: RSA SHA256:8hGnqhN3mn1VPS76dNbV39xgqnqKPoX7pTZhFGBu69A Oct 19 14:30:05.983037 sshd-session[2224]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 14:30:05.994626 systemd-logind[1664]: New session '4' of user 'core' with class 'user' and type 'tty'. Oct 19 14:30:06.000557 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 19 14:30:06.059155 etcd-wrapper[2190]: d28d4aa02c9a: Pull complete Oct 19 14:30:06.255667 etcd-wrapper[2190]: 564a832d7b24: Pull complete Oct 19 14:30:06.423456 dockerd[1947]: time="2026-10-19T14:30:06.423404985Z" level=info msg="image pulled" digest="sha256:a193bdd3c1d1d11de961b6600231b2b3b4c4e092848dbb7d4c0e03b709ac7594" remote="quay.io/coreos/etcd:v3.5.24" Oct 19 14:30:06.452213 etcd-wrapper[2190]: b5e058125d2e: Pull complete Oct 19 14:30:06.452478 sshd[2266]: Connection closed by 98.64.94.113 port 33198 Oct 19 14:30:06.453338 sshd-session[2224]: pam_unix(sshd:session): session closed for user core Oct 19 14:30:06.456874 etcd-wrapper[2190]: afae8b8aae79: Pull complete Oct 19 14:30:06.461888 systemd[1]: sshd@2-4097-172.31.29.119:22-98.64.94.113:33198.service: Deactivated successfully. Oct 19 14:30:06.462442 etcd-wrapper[2190]: d7c7ccc36d88: Pull complete Oct 19 14:30:06.462442 etcd-wrapper[2190]: Digest: sha256:a193bdd3c1d1d11de961b6600231b2b3b4c4e092848dbb7d4c0e03b709ac7594 Oct 19 14:30:06.462442 etcd-wrapper[2190]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.24 Oct 19 14:30:06.467326 systemd[1]: session-4.scope: Deactivated successfully. Oct 19 14:30:06.473997 systemd-logind[1664]: Session 4 logged out. Waiting for processes to exit. Oct 19 14:30:06.476958 systemd-logind[1664]: Removed session 4. Oct 19 14:30:06.552985 systemd[1]: tmp-containerd\x2dmount1326252440.mount: Deactivated successfully. Oct 19 14:30:06.762552 systemd[1]: var-lib-docker-rootfs-overlayfs-7c9c1a59f75b4b82251f2993891ffa4e5c6b42cbd61209874b7133492aa89df9.mount: Deactivated successfully. Oct 19 14:30:06.819074 containerd[1700]: time="2026-10-19T14:30:06.818302091Z" level=info msg="connecting to shim 7c9c1a59f75b4b82251f2993891ffa4e5c6b42cbd61209874b7133492aa89df9" address="unix:///run/containerd/s/eb1682178ee5ce7ef00385f355fc2d0cbe9535dd8840c8c50865f16f2ee61481" namespace=moby protocol=ttrpc version=3 Oct 19 14:30:06.862624 systemd[1]: Started docker-7c9c1a59f75b4b82251f2993891ffa4e5c6b42cbd61209874b7133492aa89df9.scope - libcontainer container 7c9c1a59f75b4b82251f2993891ffa4e5c6b42cbd61209874b7133492aa89df9. Oct 19 14:30:06.937593 dockerd[1947]: time="2026-10-19T14:30:06.937542671Z" level=info msg="sbJoin: gwep4 ''->'', gwep6 ''->''" eid=9e4d07e419b3 ep=etcd-member net=host nid=5f15a3b0a73e Oct 19 14:30:06.992618 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:06.992050Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Oct 19 14:30:06.993777 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:06.992454Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec21228f063f266b5d4f8ec869c54358"} Oct 19 14:30:06.993777 etcd-wrapper[2190]: {"level":"warn","ts":"2026-10-19T14:30:06.992549Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Oct 19 14:30:06.993777 etcd-wrapper[2190]: {"level":"warn","ts":"2026-10-19T14:30:06.992603Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.24"} Oct 19 14:30:06.993777 etcd-wrapper[2190]: {"level":"warn","ts":"2026-10-19T14:30:06.992654Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Oct 19 14:30:06.993777 etcd-wrapper[2190]: {"level":"warn","ts":"2026-10-19T14:30:06.992704Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Oct 19 14:30:06.993777 etcd-wrapper[2190]: {"level":"warn","ts":"2026-10-19T14:30:06.992849Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Oct 19 14:30:06.993777 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:06.992918Z","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.29.119:2379"]} Oct 19 14:30:06.993777 etcd-wrapper[2190]: {"level":"warn","ts":"2026-10-19T14:30:06.993066Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Oct 19 14:30:06.993777 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:06.993125Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Oct 19 14:30:06.999031 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:06.998621Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Oct 19 14:30:06.999380 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:06.998919Z","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":"ec21228f063f266b5d4f8ec869c54358","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.29.119:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec21228f063f266b5d4f8ec869c54358=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 14:30:07.002386 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.002036Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.45706ms"} Oct 19 14:30:07.008069 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.007566Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Oct 19 14:30:07.008643 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.007870Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Oct 19 14:30:07.008643 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.007963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Oct 19 14:30:07.009403 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.008023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Oct 19 14:30:07.009403 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.008076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Oct 19 14:30:07.009403 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.008170Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Oct 19 14:30:07.012721 etcd-wrapper[2190]: {"level":"warn","ts":"2026-10-19T14:30:07.012323Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Oct 19 14:30:07.014436 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.013926Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} Oct 19 14:30:07.014436 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.014105Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} Oct 19 14:30:07.015896 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.015611Z","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 14:30:07.017749 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.017002Z","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 14:30:07.017749 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.017506Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Oct 19 14:30:07.018835 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.018302Z","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 14:30:07.019459 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.018887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Oct 19 14:30:07.019459 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.019195Z","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 14:30:07.019996 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.019623Z","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 14:30:07.020568 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.020274Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Oct 19 14:30:07.020860 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.020440Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Oct 19 14:30:07.025464 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.024872Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"127.0.0.1:2380"} Oct 19 14:30:07.025464 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.025108Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"127.0.0.1:2380"} Oct 19 14:30:07.025772 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.024931Z","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.29.119:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Oct 19 14:30:07.409885 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.409480Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Oct 19 14:30:07.409885 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.409534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Oct 19 14:30:07.410108 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.409594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Oct 19 14:30:07.410108 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.409625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Oct 19 14:30:07.410108 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.409642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Oct 19 14:30:07.410108 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.409662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Oct 19 14:30:07.410108 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.409679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Oct 19 14:30:07.411056 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.410650Z","caller":"etcdserver/server.go:2158","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:ec21228f063f266b5d4f8ec869c54358 ClientURLs:[http://172.31.29.119:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Oct 19 14:30:07.411056 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.410668Z","caller":"etcdserver/server.go:2711","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Oct 19 14:30:07.411723 systemd[1]: Started etcd-member.service - etcd (System Application Container). Oct 19 14:30:07.413465 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 19 14:30:07.413950 systemd[1]: Startup finished in 3.538s (kernel) + 13.616s (initrd) + 25.568s (userspace) = 42.723s. Oct 19 14:30:07.416034 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.411026Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Oct 19 14:30:07.416034 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.411431Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} Oct 19 14:30:07.416034 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.411513Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Oct 19 14:30:07.416034 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.411672Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Oct 19 14:30:07.416034 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.411774Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Oct 19 14:30:07.416034 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.411812Z","caller":"etcdserver/server.go:2735","msg":"cluster version is updated","cluster-version":"3.5"} Oct 19 14:30:07.416034 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.412365Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Oct 19 14:30:07.416034 etcd-wrapper[2190]: {"level":"info","ts":"2026-10-19T14:30:07.412968Z","caller":"embed/serve.go:210","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Oct 19 14:30:16.621196 systemd[1]: Started sshd@3-4098-172.31.29.119:22-98.64.94.113:54644.service - OpenSSH per-connection server daemon (98.64.94.113:54644). Oct 19 14:30:17.463596 sshd[2349]: Accepted publickey for core from 98.64.94.113 port 54644 ssh2: RSA SHA256:8hGnqhN3mn1VPS76dNbV39xgqnqKPoX7pTZhFGBu69A Oct 19 14:30:17.466355 sshd-session[2349]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 14:30:17.475315 systemd-logind[1664]: New session '5' of user 'core' with class 'user' and type 'tty'. Oct 19 14:30:17.481587 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 19 14:30:17.934249 sshd[2353]: Connection closed by 98.64.94.113 port 54644 Oct 19 14:30:17.935173 sshd-session[2349]: pam_unix(sshd:session): session closed for user core Oct 19 14:30:17.940027 systemd[1]: sshd@3-4098-172.31.29.119:22-98.64.94.113:54644.service: Deactivated successfully. Oct 19 14:30:17.943448 systemd[1]: session-5.scope: Deactivated successfully. Oct 19 14:30:17.947326 systemd-logind[1664]: Session 5 logged out. Waiting for processes to exit. Oct 19 14:30:17.949427 systemd-logind[1664]: Removed session 5. Oct 19 14:30:18.102506 systemd[1]: Started sshd@4-3-172.31.29.119:22-98.64.94.113:54660.service - OpenSSH per-connection server daemon (98.64.94.113:54660). Oct 19 14:30:18.953275 sshd[2360]: Accepted publickey for core from 98.64.94.113 port 54660 ssh2: RSA SHA256:8hGnqhN3mn1VPS76dNbV39xgqnqKPoX7pTZhFGBu69A Oct 19 14:30:18.955300 sshd-session[2360]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 14:30:18.964337 systemd-logind[1664]: New session '6' of user 'core' with class 'user' and type 'tty'. Oct 19 14:30:18.970569 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 19 14:30:19.421613 sshd[2364]: Connection closed by 98.64.94.113 port 54660 Oct 19 14:30:19.423562 sshd-session[2360]: pam_unix(sshd:session): session closed for user core Oct 19 14:30:19.428143 systemd[1]: sshd@4-3-172.31.29.119:22-98.64.94.113:54660.service: Deactivated successfully. Oct 19 14:30:19.431872 systemd[1]: session-6.scope: Deactivated successfully. Oct 19 14:30:19.433697 systemd-logind[1664]: Session 6 logged out. Waiting for processes to exit. Oct 19 14:30:19.436387 systemd-logind[1664]: Removed session 6. Oct 19 14:30:19.590882 systemd[1]: Started sshd@5-4099-172.31.29.119:22-98.64.94.113:54672.service - OpenSSH per-connection server daemon (98.64.94.113:54672). Oct 19 14:30:20.439108 sshd[2370]: Accepted publickey for core from 98.64.94.113 port 54672 ssh2: RSA SHA256:8hGnqhN3mn1VPS76dNbV39xgqnqKPoX7pTZhFGBu69A Oct 19 14:30:20.442410 sshd-session[2370]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 14:30:20.452163 systemd-logind[1664]: New session '7' of user 'core' with class 'user' and type 'tty'. Oct 19 14:30:20.459634 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 19 14:30:20.913467 sshd[2374]: Connection closed by 98.64.94.113 port 54672 Oct 19 14:30:20.915476 sshd-session[2370]: pam_unix(sshd:session): session closed for user core Oct 19 14:30:20.920071 systemd[1]: sshd@5-4099-172.31.29.119:22-98.64.94.113:54672.service: Deactivated successfully. Oct 19 14:30:20.924918 systemd[1]: session-7.scope: Deactivated successfully. Oct 19 14:30:20.928403 systemd-logind[1664]: Session 7 logged out. Waiting for processes to exit. Oct 19 14:30:20.930410 systemd-logind[1664]: Removed session 7. Oct 19 14:30:21.080664 systemd[1]: Started sshd@6-4100-172.31.29.119:22-98.64.94.113:52222.service - OpenSSH per-connection server daemon (98.64.94.113:52222). Oct 19 14:30:21.920781 sshd[2380]: Accepted publickey for core from 98.64.94.113 port 52222 ssh2: RSA SHA256:8hGnqhN3mn1VPS76dNbV39xgqnqKPoX7pTZhFGBu69A Oct 19 14:30:21.922667 sshd-session[2380]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 14:30:21.931910 systemd-logind[1664]: New session '8' of user 'core' with class 'user' and type 'tty'. Oct 19 14:30:21.933602 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 19 14:30:22.384456 sshd[2384]: Connection closed by 98.64.94.113 port 52222 Oct 19 14:30:22.385389 sshd-session[2380]: pam_unix(sshd:session): session closed for user core Oct 19 14:30:22.390961 systemd[1]: sshd@6-4100-172.31.29.119:22-98.64.94.113:52222.service: Deactivated successfully. Oct 19 14:30:22.394812 systemd[1]: session-8.scope: Deactivated successfully. Oct 19 14:30:22.396473 systemd-logind[1664]: Session 8 logged out. Waiting for processes to exit. Oct 19 14:30:22.399339 systemd-logind[1664]: Removed session 8. Oct 19 14:30:22.552702 systemd[1]: Started sshd@7-4101-172.31.29.119:22-98.64.94.113:52238.service - OpenSSH per-connection server daemon (98.64.94.113:52238). Oct 19 14:30:23.399026 sshd[2390]: Accepted publickey for core from 98.64.94.113 port 52238 ssh2: RSA SHA256:8hGnqhN3mn1VPS76dNbV39xgqnqKPoX7pTZhFGBu69A Oct 19 14:30:23.401963 sshd-session[2390]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 19 14:30:23.411340 systemd-logind[1664]: New session '9' of user 'core' with class 'user' and type 'tty'. Oct 19 14:30:23.417574 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 19 14:30:23.980688 sshd[2394]: Connection closed by 98.64.94.113 port 52238 Oct 19 14:30:23.982504 sshd-session[2390]: pam_unix(sshd:session): session closed for user core Oct 19 14:30:23.987392 systemd[1]: sshd@7-4101-172.31.29.119:22-98.64.94.113:52238.service: Deactivated successfully. Oct 19 14:30:23.991025 systemd[1]: session-9.scope: Deactivated successfully. Oct 19 14:30:23.992734 systemd-logind[1664]: Session 9 logged out. Waiting for processes to exit. Oct 19 14:30:23.995512 systemd-logind[1664]: Removed session 9. Oct 19 14:30:26.484625 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Oct 19 14:30:40.694432 update_engine[1665]: I20261019 14:30:40.694321 1665 update_attempter.cc:509] Updating boot flags... Oct 19 14:32:41.790408 update_engine[1665]: I20261019 14:32:41.790328 1665 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs Oct 19 14:32:41.790408 update_engine[1665]: I20261019 14:32:41.790400 1665 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs Oct 19 14:32:41.791267 update_engine[1665]: I20261019 14:32:41.790722 1665 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs Oct 19 14:32:41.792292 update_engine[1665]: I20261019 14:32:41.791549 1665 omaha_request_params.cc:62] Current group set to developer Oct 19 14:32:41.792292 update_engine[1665]: I20261019 14:32:41.791944 1665 update_attempter.cc:499] Already updated boot flags. Skipping. Oct 19 14:32:41.792292 update_engine[1665]: I20261019 14:32:41.791971 1665 update_attempter.cc:643] Scheduling an action processor start. Oct 19 14:32:41.792292 update_engine[1665]: I20261019 14:32:41.792006 1665 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 19 14:32:41.792703 update_engine[1665]: I20261019 14:32:41.792647 1665 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs Oct 19 14:32:41.792994 update_engine[1665]: I20261019 14:32:41.792788 1665 omaha_request_action.cc:271] Posting an Omaha request to disabled Oct 19 14:32:41.792994 update_engine[1665]: I20261019 14:32:41.792814 1665 omaha_request_action.cc:272] Request: Oct 19 14:32:41.792994 update_engine[1665]: Oct 19 14:32:41.792994 update_engine[1665]: Oct 19 14:32:41.792994 update_engine[1665]: Oct 19 14:32:41.792994 update_engine[1665]: Oct 19 14:32:41.792994 update_engine[1665]: Oct 19 14:32:41.792994 update_engine[1665]: Oct 19 14:32:41.792994 update_engine[1665]: Oct 19 14:32:41.792994 update_engine[1665]: Oct 19 14:32:41.792994 update_engine[1665]: I20261019 14:32:41.792831 1665 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Oct 19 14:32:41.794046 locksmithd[1730]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0 Oct 19 14:32:41.796680 update_engine[1665]: I20261019 14:32:41.796612 1665 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Oct 19 14:32:41.797778 update_engine[1665]: I20261019 14:32:41.797724 1665 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Oct 19 14:32:41.831098 update_engine[1665]: E20261019 14:32:41.831032 1665 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (Domain name not found) Oct 19 14:32:41.831201 update_engine[1665]: I20261019 14:32:41.831121 1665 libcurl_http_fetcher.cc:283] No HTTP response, retry 1 Oct 19 14:32:51.693194 update_engine[1665]: I20261019 14:32:51.693048 1665 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Oct 19 14:32:51.693856 update_engine[1665]: I20261019 14:32:51.693189 1665 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Oct 19 14:32:51.693856 update_engine[1665]: I20261019 14:32:51.693722 1665 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Oct 19 14:32:51.694339 update_engine[1665]: E20261019 14:32:51.694276 1665 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (Domain name not found) Oct 19 14:32:51.694429 update_engine[1665]: I20261019 14:32:51.694350 1665 libcurl_http_fetcher.cc:283] No HTTP response, retry 2 Oct 19 14:33:01.700363 update_engine[1665]: I20261019 14:33:01.700269 1665 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Oct 19 14:33:01.700953 update_engine[1665]: I20261019 14:33:01.700409 1665 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Oct 19 14:33:01.700953 update_engine[1665]: I20261019 14:33:01.700889 1665 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Oct 19 14:33:01.701863 update_engine[1665]: E20261019 14:33:01.701808 1665 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (Domain name not found) Oct 19 14:33:01.701957 update_engine[1665]: I20261019 14:33:01.701880 1665 libcurl_http_fetcher.cc:283] No HTTP response, retry 3 Oct 19 14:33:11.693991 update_engine[1665]: I20261019 14:33:11.693897 1665 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Oct 19 14:33:11.694729 update_engine[1665]: I20261019 14:33:11.694041 1665 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Oct 19 14:33:11.694729 update_engine[1665]: I20261019 14:33:11.694527 1665 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Oct 19 14:33:11.695264 update_engine[1665]: E20261019 14:33:11.695196 1665 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (Domain name not found) Oct 19 14:33:11.695345 update_engine[1665]: I20261019 14:33:11.695282 1665 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Oct 19 14:33:11.695345 update_engine[1665]: I20261019 14:33:11.695302 1665 omaha_request_action.cc:617] Omaha request response: Oct 19 14:33:11.695446 update_engine[1665]: E20261019 14:33:11.695415 1665 omaha_request_action.cc:636] Omaha request network transfer failed. Oct 19 14:33:11.695504 update_engine[1665]: I20261019 14:33:11.695446 1665 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaRequestAction action failed. Aborting processing. Oct 19 14:33:11.695504 update_engine[1665]: I20261019 14:33:11.695461 1665 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 19 14:33:11.695504 update_engine[1665]: I20261019 14:33:11.695475 1665 update_attempter.cc:306] Processing Done. Oct 19 14:33:11.695640 update_engine[1665]: E20261019 14:33:11.695499 1665 update_attempter.cc:619] Update failed. Oct 19 14:33:11.695640 update_engine[1665]: I20261019 14:33:11.695515 1665 utils.cc:600] Converting error code 2000 to kActionCodeOmahaErrorInHTTPResponse Oct 19 14:33:11.695640 update_engine[1665]: I20261019 14:33:11.695529 1665 payload_state.cc:97] Updating payload state for error code: 37 (kActionCodeOmahaErrorInHTTPResponse) Oct 19 14:33:11.695640 update_engine[1665]: I20261019 14:33:11.695544 1665 payload_state.cc:103] Ignoring failures until we get a valid Omaha response. Oct 19 14:33:11.695819 update_engine[1665]: I20261019 14:33:11.695650 1665 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Oct 19 14:33:11.695819 update_engine[1665]: I20261019 14:33:11.695685 1665 omaha_request_action.cc:271] Posting an Omaha request to disabled Oct 19 14:33:11.695819 update_engine[1665]: I20261019 14:33:11.695701 1665 omaha_request_action.cc:272] Request: Oct 19 14:33:11.695819 update_engine[1665]: Oct 19 14:33:11.695819 update_engine[1665]: Oct 19 14:33:11.695819 update_engine[1665]: Oct 19 14:33:11.695819 update_engine[1665]: Oct 19 14:33:11.695819 update_engine[1665]: Oct 19 14:33:11.695819 update_engine[1665]: Oct 19 14:33:11.695819 update_engine[1665]: I20261019 14:33:11.695719 1665 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Oct 19 14:33:11.695819 update_engine[1665]: I20261019 14:33:11.695778 1665 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Oct 19 14:33:11.696397 update_engine[1665]: I20261019 14:33:11.696171 1665 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Oct 19 14:33:11.696678 locksmithd[1730]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_REPORTING_ERROR_EVENT" NewVersion=0.0.0 NewSize=0 Oct 19 14:33:11.697366 update_engine[1665]: E20261019 14:33:11.696995 1665 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled (Domain name not found) Oct 19 14:33:11.697366 update_engine[1665]: I20261019 14:33:11.697060 1665 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Oct 19 14:33:11.697366 update_engine[1665]: I20261019 14:33:11.697077 1665 omaha_request_action.cc:617] Omaha request response: Oct 19 14:33:11.697366 update_engine[1665]: I20261019 14:33:11.697093 1665 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 19 14:33:11.697366 update_engine[1665]: I20261019 14:33:11.697108 1665 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Oct 19 14:33:11.697366 update_engine[1665]: I20261019 14:33:11.697120 1665 update_attempter.cc:306] Processing Done. Oct 19 14:33:11.697366 update_engine[1665]: I20261019 14:33:11.697135 1665 update_attempter.cc:310] Error event sent. Oct 19 14:33:11.697366 update_engine[1665]: I20261019 14:33:11.697161 1665 update_check_scheduler.cc:74] Next update check in 45m14s Oct 19 14:33:11.697959 locksmithd[1730]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_IDLE" NewVersion=0.0.0 NewSize=0