Sep 9 23:42:38.157150 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Sep 9 23:42:38.157197 kernel: Linux version 6.12.45-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT Tue Sep 9 22:10:22 -00 2025 Sep 9 23:42:38.157221 kernel: KASLR disabled due to lack of seed Sep 9 23:42:38.157237 kernel: efi: EFI v2.7 by EDK II Sep 9 23:42:38.157254 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7a731a98 MEMRESERVE=0x78557598 Sep 9 23:42:38.157269 kernel: secureboot: Secure boot disabled Sep 9 23:42:38.157319 kernel: ACPI: Early table checksum verification disabled Sep 9 23:42:38.157336 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Sep 9 23:42:38.157352 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Sep 9 23:42:38.157367 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Sep 9 23:42:38.157383 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Sep 9 23:42:38.157405 kernel: ACPI: FACS 0x0000000078630000 000040 Sep 9 23:42:38.157420 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Sep 9 23:42:38.157435 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Sep 9 23:42:38.157452 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Sep 9 23:42:38.157468 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Sep 9 23:42:38.157488 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Sep 9 23:42:38.157504 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Sep 9 23:42:38.157520 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Sep 9 23:42:38.157535 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Sep 9 23:42:38.157551 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Sep 9 23:42:38.157567 kernel: printk: legacy bootconsole [uart0] enabled Sep 9 23:42:38.157582 kernel: ACPI: Use ACPI SPCR as default console: No Sep 9 23:42:38.157598 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Sep 9 23:42:38.157614 kernel: NODE_DATA(0) allocated [mem 0x4b584ca00-0x4b5853fff] Sep 9 23:42:38.157629 kernel: Zone ranges: Sep 9 23:42:38.157645 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Sep 9 23:42:38.157664 kernel: DMA32 empty Sep 9 23:42:38.157680 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Sep 9 23:42:38.157695 kernel: Device empty Sep 9 23:42:38.157711 kernel: Movable zone start for each node Sep 9 23:42:38.157726 kernel: Early memory node ranges Sep 9 23:42:38.157742 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Sep 9 23:42:38.157758 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Sep 9 23:42:38.157773 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Sep 9 23:42:38.157789 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Sep 9 23:42:38.157804 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Sep 9 23:42:38.157820 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Sep 9 23:42:38.157836 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Sep 9 23:42:38.157856 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Sep 9 23:42:38.157878 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Sep 9 23:42:38.157895 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Sep 9 23:42:38.157911 kernel: cma: Reserved 16 MiB at 0x000000007f000000 on node -1 Sep 9 23:42:38.157928 kernel: psci: probing for conduit method from ACPI. Sep 9 23:42:38.157948 kernel: psci: PSCIv1.0 detected in firmware. Sep 9 23:42:38.157964 kernel: psci: Using standard PSCI v0.2 function IDs Sep 9 23:42:38.157981 kernel: psci: Trusted OS migration not required Sep 9 23:42:38.157997 kernel: psci: SMC Calling Convention v1.1 Sep 9 23:42:38.158013 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Sep 9 23:42:38.158030 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Sep 9 23:42:38.158046 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Sep 9 23:42:38.158063 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 9 23:42:38.158079 kernel: Detected PIPT I-cache on CPU0 Sep 9 23:42:38.158096 kernel: CPU features: detected: GIC system register CPU interface Sep 9 23:42:38.158112 kernel: CPU features: detected: Spectre-v2 Sep 9 23:42:38.158133 kernel: CPU features: detected: Spectre-v3a Sep 9 23:42:38.158149 kernel: CPU features: detected: Spectre-BHB Sep 9 23:42:38.158166 kernel: CPU features: detected: ARM erratum 1742098 Sep 9 23:42:38.158182 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Sep 9 23:42:38.158198 kernel: alternatives: applying boot alternatives Sep 9 23:42:38.158216 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=fc7b279c2d918629032c01551b74c66c198cf923a976f9b3bc0d959e7c2302db Sep 9 23:42:38.158234 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 9 23:42:38.158252 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 9 23:42:38.158269 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 9 23:42:38.158310 kernel: Fallback order for Node 0: 0 Sep 9 23:42:38.158337 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1007616 Sep 9 23:42:38.158354 kernel: Policy zone: Normal Sep 9 23:42:38.158370 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 9 23:42:38.158386 kernel: software IO TLB: area num 2. Sep 9 23:42:38.158403 kernel: software IO TLB: mapped [mem 0x000000006c600000-0x0000000070600000] (64MB) Sep 9 23:42:38.158419 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 9 23:42:38.158436 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 9 23:42:38.158453 kernel: rcu: RCU event tracing is enabled. Sep 9 23:42:38.158470 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 9 23:42:38.158487 kernel: Trampoline variant of Tasks RCU enabled. Sep 9 23:42:38.158504 kernel: Tracing variant of Tasks RCU enabled. Sep 9 23:42:38.158521 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 9 23:42:38.158542 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 9 23:42:38.158559 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 9 23:42:38.158576 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 9 23:42:38.158592 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 9 23:42:38.158608 kernel: GICv3: 96 SPIs implemented Sep 9 23:42:38.158625 kernel: GICv3: 0 Extended SPIs implemented Sep 9 23:42:38.158641 kernel: Root IRQ handler: gic_handle_irq Sep 9 23:42:38.158658 kernel: GICv3: GICv3 features: 16 PPIs Sep 9 23:42:38.158674 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Sep 9 23:42:38.158691 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Sep 9 23:42:38.158707 kernel: ITS [mem 0x10080000-0x1009ffff] Sep 9 23:42:38.158724 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000f0000 (indirect, esz 8, psz 64K, shr 1) Sep 9 23:42:38.158746 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @400100000 (flat, esz 8, psz 64K, shr 1) Sep 9 23:42:38.158763 kernel: GICv3: using LPI property table @0x0000000400110000 Sep 9 23:42:38.158780 kernel: ITS: Using hypervisor restricted LPI range [128] Sep 9 23:42:38.158796 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000400120000 Sep 9 23:42:38.158813 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 9 23:42:38.158829 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Sep 9 23:42:38.158846 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Sep 9 23:42:38.158863 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Sep 9 23:42:38.158880 kernel: Console: colour dummy device 80x25 Sep 9 23:42:38.158898 kernel: printk: legacy console [tty1] enabled Sep 9 23:42:38.158915 kernel: ACPI: Core revision 20240827 Sep 9 23:42:38.158937 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Sep 9 23:42:38.158955 kernel: pid_max: default: 32768 minimum: 301 Sep 9 23:42:38.158971 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 9 23:42:38.158988 kernel: landlock: Up and running. Sep 9 23:42:38.159005 kernel: SELinux: Initializing. Sep 9 23:42:38.159022 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 23:42:38.159039 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 23:42:38.159056 kernel: rcu: Hierarchical SRCU implementation. Sep 9 23:42:38.159073 kernel: rcu: Max phase no-delay instances is 400. Sep 9 23:42:38.159095 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 9 23:42:38.159112 kernel: Remapping and enabling EFI services. Sep 9 23:42:38.159129 kernel: smp: Bringing up secondary CPUs ... Sep 9 23:42:38.159147 kernel: Detected PIPT I-cache on CPU1 Sep 9 23:42:38.159164 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Sep 9 23:42:38.159182 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000400130000 Sep 9 23:42:38.159199 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Sep 9 23:42:38.159216 kernel: smp: Brought up 1 node, 2 CPUs Sep 9 23:42:38.159234 kernel: SMP: Total of 2 processors activated. Sep 9 23:42:38.159267 kernel: CPU: All CPU(s) started at EL1 Sep 9 23:42:38.159314 kernel: CPU features: detected: 32-bit EL0 Support Sep 9 23:42:38.159342 kernel: CPU features: detected: 32-bit EL1 Support Sep 9 23:42:38.159361 kernel: CPU features: detected: CRC32 instructions Sep 9 23:42:38.159379 kernel: alternatives: applying system-wide alternatives Sep 9 23:42:38.159399 kernel: Memory: 3797096K/4030464K available (11136K kernel code, 2436K rwdata, 9060K rodata, 38912K init, 1038K bss, 212024K reserved, 16384K cma-reserved) Sep 9 23:42:38.159418 kernel: devtmpfs: initialized Sep 9 23:42:38.159441 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 9 23:42:38.159460 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Sep 9 23:42:38.159501 kernel: 17056 pages in range for non-PLT usage Sep 9 23:42:38.159527 kernel: 508576 pages in range for PLT usage Sep 9 23:42:38.159545 kernel: pinctrl core: initialized pinctrl subsystem Sep 9 23:42:38.159565 kernel: SMBIOS 3.0.0 present. Sep 9 23:42:38.159584 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Sep 9 23:42:38.159603 kernel: DMI: Memory slots populated: 0/0 Sep 9 23:42:38.159621 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 9 23:42:38.159646 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 9 23:42:38.159665 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 9 23:42:38.159683 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 9 23:42:38.159701 kernel: audit: initializing netlink subsys (disabled) Sep 9 23:42:38.159719 kernel: audit: type=2000 audit(0.283:1): state=initialized audit_enabled=0 res=1 Sep 9 23:42:38.159737 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 9 23:42:38.159754 kernel: cpuidle: using governor menu Sep 9 23:42:38.159772 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 9 23:42:38.159790 kernel: ASID allocator initialised with 65536 entries Sep 9 23:42:38.159814 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 9 23:42:38.159832 kernel: Serial: AMBA PL011 UART driver Sep 9 23:42:38.159850 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 9 23:42:38.159868 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 9 23:42:38.159886 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 9 23:42:38.159905 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 9 23:42:38.159923 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 9 23:42:38.159943 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 9 23:42:38.159961 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 9 23:42:38.159984 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 9 23:42:38.160003 kernel: ACPI: Added _OSI(Module Device) Sep 9 23:42:38.160021 kernel: ACPI: Added _OSI(Processor Device) Sep 9 23:42:38.160039 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 9 23:42:38.160057 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 9 23:42:38.160075 kernel: ACPI: Interpreter enabled Sep 9 23:42:38.160093 kernel: ACPI: Using GIC for interrupt routing Sep 9 23:42:38.160112 kernel: ACPI: MCFG table detected, 1 entries Sep 9 23:42:38.160130 kernel: ACPI: CPU0 has been hot-added Sep 9 23:42:38.160152 kernel: ACPI: CPU1 has been hot-added Sep 9 23:42:38.160172 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Sep 9 23:42:38.163267 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 9 23:42:38.163581 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 9 23:42:38.163791 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 9 23:42:38.163983 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Sep 9 23:42:38.164173 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Sep 9 23:42:38.164212 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Sep 9 23:42:38.164232 kernel: acpiphp: Slot [1] registered Sep 9 23:42:38.164251 kernel: acpiphp: Slot [2] registered Sep 9 23:42:38.164269 kernel: acpiphp: Slot [3] registered Sep 9 23:42:38.164588 kernel: acpiphp: Slot [4] registered Sep 9 23:42:38.164614 kernel: acpiphp: Slot [5] registered Sep 9 23:42:38.164632 kernel: acpiphp: Slot [6] registered Sep 9 23:42:38.164650 kernel: acpiphp: Slot [7] registered Sep 9 23:42:38.164668 kernel: acpiphp: Slot [8] registered Sep 9 23:42:38.164686 kernel: acpiphp: Slot [9] registered Sep 9 23:42:38.164714 kernel: acpiphp: Slot [10] registered Sep 9 23:42:38.164732 kernel: acpiphp: Slot [11] registered Sep 9 23:42:38.164750 kernel: acpiphp: Slot [12] registered Sep 9 23:42:38.164768 kernel: acpiphp: Slot [13] registered Sep 9 23:42:38.164786 kernel: acpiphp: Slot [14] registered Sep 9 23:42:38.164804 kernel: acpiphp: Slot [15] registered Sep 9 23:42:38.164822 kernel: acpiphp: Slot [16] registered Sep 9 23:42:38.164840 kernel: acpiphp: Slot [17] registered Sep 9 23:42:38.164858 kernel: acpiphp: Slot [18] registered Sep 9 23:42:38.164882 kernel: acpiphp: Slot [19] registered Sep 9 23:42:38.164901 kernel: acpiphp: Slot [20] registered Sep 9 23:42:38.164920 kernel: acpiphp: Slot [21] registered Sep 9 23:42:38.164938 kernel: acpiphp: Slot [22] registered Sep 9 23:42:38.164956 kernel: acpiphp: Slot [23] registered Sep 9 23:42:38.164974 kernel: acpiphp: Slot [24] registered Sep 9 23:42:38.164992 kernel: acpiphp: Slot [25] registered Sep 9 23:42:38.165010 kernel: acpiphp: Slot [26] registered Sep 9 23:42:38.165028 kernel: acpiphp: Slot [27] registered Sep 9 23:42:38.165046 kernel: acpiphp: Slot [28] registered Sep 9 23:42:38.165069 kernel: acpiphp: Slot [29] registered Sep 9 23:42:38.165087 kernel: acpiphp: Slot [30] registered Sep 9 23:42:38.165105 kernel: acpiphp: Slot [31] registered Sep 9 23:42:38.165122 kernel: PCI host bridge to bus 0000:00 Sep 9 23:42:38.165413 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Sep 9 23:42:38.165598 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 9 23:42:38.165769 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Sep 9 23:42:38.165938 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Sep 9 23:42:38.166177 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 conventional PCI endpoint Sep 9 23:42:38.166436 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 conventional PCI endpoint Sep 9 23:42:38.166634 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff] Sep 9 23:42:38.166847 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 PCIe Root Complex Integrated Endpoint Sep 9 23:42:38.167043 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80114000-0x80117fff] Sep 9 23:42:38.167231 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 9 23:42:38.167580 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 PCIe Root Complex Integrated Endpoint Sep 9 23:42:38.167803 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80110000-0x80113fff] Sep 9 23:42:38.168016 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref] Sep 9 23:42:38.168216 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff] Sep 9 23:42:38.168520 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 9 23:42:38.168750 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref]: assigned Sep 9 23:42:38.168953 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff]: assigned Sep 9 23:42:38.169168 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80110000-0x80113fff]: assigned Sep 9 23:42:38.169440 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80114000-0x80117fff]: assigned Sep 9 23:42:38.169681 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff]: assigned Sep 9 23:42:38.169888 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Sep 9 23:42:38.170080 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 9 23:42:38.170258 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Sep 9 23:42:38.170354 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 9 23:42:38.170376 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 9 23:42:38.170395 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 9 23:42:38.170415 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 9 23:42:38.170433 kernel: iommu: Default domain type: Translated Sep 9 23:42:38.170451 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 9 23:42:38.170470 kernel: efivars: Registered efivars operations Sep 9 23:42:38.170488 kernel: vgaarb: loaded Sep 9 23:42:38.170506 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 9 23:42:38.170524 kernel: VFS: Disk quotas dquot_6.6.0 Sep 9 23:42:38.170550 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 9 23:42:38.170568 kernel: pnp: PnP ACPI init Sep 9 23:42:38.170800 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Sep 9 23:42:38.170832 kernel: pnp: PnP ACPI: found 1 devices Sep 9 23:42:38.170851 kernel: NET: Registered PF_INET protocol family Sep 9 23:42:38.170869 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 9 23:42:38.170888 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 9 23:42:38.170907 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 9 23:42:38.170931 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 9 23:42:38.170950 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 9 23:42:38.170968 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 9 23:42:38.170986 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 23:42:38.171005 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 23:42:38.171023 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 9 23:42:38.171041 kernel: PCI: CLS 0 bytes, default 64 Sep 9 23:42:38.171058 kernel: kvm [1]: HYP mode not available Sep 9 23:42:38.171076 kernel: Initialise system trusted keyrings Sep 9 23:42:38.171100 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 9 23:42:38.171118 kernel: Key type asymmetric registered Sep 9 23:42:38.171136 kernel: Asymmetric key parser 'x509' registered Sep 9 23:42:38.171154 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 9 23:42:38.171172 kernel: io scheduler mq-deadline registered Sep 9 23:42:38.171190 kernel: io scheduler kyber registered Sep 9 23:42:38.171208 kernel: io scheduler bfq registered Sep 9 23:42:38.171543 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Sep 9 23:42:38.171588 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 9 23:42:38.171608 kernel: ACPI: button: Power Button [PWRB] Sep 9 23:42:38.171625 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Sep 9 23:42:38.171643 kernel: ACPI: button: Sleep Button [SLPB] Sep 9 23:42:38.171661 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 9 23:42:38.171680 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Sep 9 23:42:38.171887 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Sep 9 23:42:38.171915 kernel: printk: legacy console [ttyS0] disabled Sep 9 23:42:38.171934 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Sep 9 23:42:38.171958 kernel: printk: legacy console [ttyS0] enabled Sep 9 23:42:38.171976 kernel: printk: legacy bootconsole [uart0] disabled Sep 9 23:42:38.171994 kernel: thunder_xcv, ver 1.0 Sep 9 23:42:38.172011 kernel: thunder_bgx, ver 1.0 Sep 9 23:42:38.172029 kernel: nicpf, ver 1.0 Sep 9 23:42:38.172046 kernel: nicvf, ver 1.0 Sep 9 23:42:38.172256 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 9 23:42:38.172484 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-09T23:42:37 UTC (1757461357) Sep 9 23:42:38.172519 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 9 23:42:38.172537 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 (0,80000003) counters available Sep 9 23:42:38.172555 kernel: NET: Registered PF_INET6 protocol family Sep 9 23:42:38.172572 kernel: watchdog: NMI not fully supported Sep 9 23:42:38.172590 kernel: watchdog: Hard watchdog permanently disabled Sep 9 23:42:38.172608 kernel: Segment Routing with IPv6 Sep 9 23:42:38.172625 kernel: In-situ OAM (IOAM) with IPv6 Sep 9 23:42:38.172643 kernel: NET: Registered PF_PACKET protocol family Sep 9 23:42:38.172660 kernel: Key type dns_resolver registered Sep 9 23:42:38.172683 kernel: registered taskstats version 1 Sep 9 23:42:38.172701 kernel: Loading compiled-in X.509 certificates Sep 9 23:42:38.172720 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.45-flatcar: 61217a1897415238555e2058a4e44c51622b0f87' Sep 9 23:42:38.172740 kernel: Demotion targets for Node 0: null Sep 9 23:42:38.172758 kernel: Key type .fscrypt registered Sep 9 23:42:38.172777 kernel: Key type fscrypt-provisioning registered Sep 9 23:42:38.172796 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 9 23:42:38.172814 kernel: ima: Allocated hash algorithm: sha1 Sep 9 23:42:38.172833 kernel: ima: No architecture policies found Sep 9 23:42:38.172858 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 9 23:42:38.172877 kernel: clk: Disabling unused clocks Sep 9 23:42:38.172894 kernel: PM: genpd: Disabling unused power domains Sep 9 23:42:38.172912 kernel: Warning: unable to open an initial console. Sep 9 23:42:38.172930 kernel: Freeing unused kernel memory: 38912K Sep 9 23:42:38.172948 kernel: Run /init as init process Sep 9 23:42:38.172965 kernel: with arguments: Sep 9 23:42:38.172982 kernel: /init Sep 9 23:42:38.172999 kernel: with environment: Sep 9 23:42:38.173016 kernel: HOME=/ Sep 9 23:42:38.173038 kernel: TERM=linux Sep 9 23:42:38.173056 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 9 23:42:38.173076 systemd[1]: Successfully made /usr/ read-only. Sep 9 23:42:38.173100 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 9 23:42:38.173121 systemd[1]: Detected virtualization amazon. Sep 9 23:42:38.173140 systemd[1]: Detected architecture arm64. Sep 9 23:42:38.173158 systemd[1]: Running in initrd. Sep 9 23:42:38.173181 systemd[1]: No hostname configured, using default hostname. Sep 9 23:42:38.173200 systemd[1]: Hostname set to . Sep 9 23:42:38.173219 systemd[1]: Initializing machine ID from VM UUID. Sep 9 23:42:38.173238 systemd[1]: Queued start job for default target initrd.target. Sep 9 23:42:38.173257 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 23:42:38.173276 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 23:42:38.173329 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 9 23:42:38.173351 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 23:42:38.173378 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 9 23:42:38.173400 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 9 23:42:38.173422 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 9 23:42:38.173441 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 9 23:42:38.173462 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 23:42:38.173481 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 23:42:38.173500 systemd[1]: Reached target paths.target - Path Units. Sep 9 23:42:38.173523 systemd[1]: Reached target slices.target - Slice Units. Sep 9 23:42:38.173542 systemd[1]: Reached target swap.target - Swaps. Sep 9 23:42:38.173562 systemd[1]: Reached target timers.target - Timer Units. Sep 9 23:42:38.173581 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 23:42:38.173601 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 23:42:38.173620 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 9 23:42:38.173640 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 9 23:42:38.173659 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 9 23:42:38.173684 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 23:42:38.173703 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 23:42:38.173722 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 23:42:38.173742 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 9 23:42:38.173761 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 23:42:38.173780 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 9 23:42:38.173800 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Sep 9 23:42:38.173819 systemd[1]: Starting systemd-fsck-usr.service... Sep 9 23:42:38.173838 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 23:42:38.173862 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 23:42:38.173882 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:42:38.173901 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 9 23:42:38.173921 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 23:42:38.173945 systemd[1]: Finished systemd-fsck-usr.service. Sep 9 23:42:38.174023 systemd-journald[257]: Collecting audit messages is disabled. Sep 9 23:42:38.174070 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 9 23:42:38.174091 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 9 23:42:38.174116 systemd-journald[257]: Journal started Sep 9 23:42:38.174164 systemd-journald[257]: Runtime Journal (/run/log/journal/ec21b1aade41d152bfc0d69fa95bc640) is 8M, max 75.3M, 67.3M free. Sep 9 23:42:38.123610 systemd-modules-load[259]: Inserted module 'overlay' Sep 9 23:42:38.179469 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 23:42:38.187645 kernel: Bridge firewalling registered Sep 9 23:42:38.186732 systemd-modules-load[259]: Inserted module 'br_netfilter' Sep 9 23:42:38.190659 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 23:42:38.196841 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 23:42:38.207734 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 23:42:38.247590 systemd-tmpfiles[271]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 9 23:42:38.254744 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:42:38.262742 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 23:42:38.270514 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 23:42:38.277715 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 9 23:42:38.293175 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 23:42:38.307611 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 23:42:38.321202 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 23:42:38.342384 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 23:42:38.360180 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 23:42:38.375665 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 9 23:42:38.429085 dracut-cmdline[301]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=fc7b279c2d918629032c01551b74c66c198cf923a976f9b3bc0d959e7c2302db Sep 9 23:42:38.476646 systemd-resolved[289]: Positive Trust Anchors: Sep 9 23:42:38.476684 systemd-resolved[289]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 23:42:38.476747 systemd-resolved[289]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 9 23:42:38.613336 kernel: SCSI subsystem initialized Sep 9 23:42:38.621327 kernel: Loading iSCSI transport class v2.0-870. Sep 9 23:42:38.634346 kernel: iscsi: registered transport (tcp) Sep 9 23:42:38.656881 kernel: iscsi: registered transport (qla4xxx) Sep 9 23:42:38.656968 kernel: QLogic iSCSI HBA Driver Sep 9 23:42:38.693450 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 9 23:42:38.728516 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 23:42:38.743641 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 9 23:42:38.767325 kernel: random: crng init done Sep 9 23:42:38.767747 systemd-resolved[289]: Defaulting to hostname 'linux'. Sep 9 23:42:38.773180 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 23:42:38.779315 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 23:42:38.860434 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 9 23:42:38.862134 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 9 23:42:38.961332 kernel: raid6: neonx8 gen() 6449 MB/s Sep 9 23:42:38.978320 kernel: raid6: neonx4 gen() 6439 MB/s Sep 9 23:42:38.995318 kernel: raid6: neonx2 gen() 5346 MB/s Sep 9 23:42:39.012318 kernel: raid6: neonx1 gen() 3924 MB/s Sep 9 23:42:39.029339 kernel: raid6: int64x8 gen() 3631 MB/s Sep 9 23:42:39.046335 kernel: raid6: int64x4 gen() 3673 MB/s Sep 9 23:42:39.063332 kernel: raid6: int64x2 gen() 3559 MB/s Sep 9 23:42:39.081364 kernel: raid6: int64x1 gen() 2764 MB/s Sep 9 23:42:39.081433 kernel: raid6: using algorithm neonx8 gen() 6449 MB/s Sep 9 23:42:39.100339 kernel: raid6: .... xor() 4658 MB/s, rmw enabled Sep 9 23:42:39.100403 kernel: raid6: using neon recovery algorithm Sep 9 23:42:39.109010 kernel: xor: measuring software checksum speed Sep 9 23:42:39.109066 kernel: 8regs : 12926 MB/sec Sep 9 23:42:39.110209 kernel: 32regs : 13048 MB/sec Sep 9 23:42:39.112535 kernel: arm64_neon : 8690 MB/sec Sep 9 23:42:39.112571 kernel: xor: using function: 32regs (13048 MB/sec) Sep 9 23:42:39.205385 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 9 23:42:39.218767 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 9 23:42:39.231149 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 23:42:39.279822 systemd-udevd[508]: Using default interface naming scheme 'v255'. Sep 9 23:42:39.290445 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 23:42:39.308623 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 9 23:42:39.351347 dracut-pre-trigger[518]: rd.md=0: removing MD RAID activation Sep 9 23:42:39.399385 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 23:42:39.411829 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 23:42:39.548596 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 23:42:39.565565 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 9 23:42:39.738275 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Sep 9 23:42:39.738381 kernel: nvme nvme0: pci function 0000:00:04.0 Sep 9 23:42:39.747875 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 9 23:42:39.747944 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Sep 9 23:42:39.754613 kernel: ena 0000:00:05.0: ENA device version: 0.10 Sep 9 23:42:39.754978 kernel: nvme nvme0: 2/0/0 default/read/poll queues Sep 9 23:42:39.758428 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Sep 9 23:42:39.772319 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Sep 9 23:42:39.772386 kernel: GPT:9289727 != 16777215 Sep 9 23:42:39.772410 kernel: GPT:Alternate GPT header not at the end of the disk. Sep 9 23:42:39.775032 kernel: GPT:9289727 != 16777215 Sep 9 23:42:39.776582 kernel: GPT: Use GNU Parted to correct GPT errors. Sep 9 23:42:39.778199 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 9 23:42:39.791355 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:51:98:f1:44:63 Sep 9 23:42:39.798030 (udev-worker)[555]: Network interface NamePolicy= disabled on kernel command line. Sep 9 23:42:39.810921 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 23:42:39.811504 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:42:39.824093 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:42:39.833258 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:42:39.839862 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 9 23:42:39.859342 kernel: nvme nvme0: using unchecked data buffer Sep 9 23:42:39.903539 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:42:40.028836 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Sep 9 23:42:40.060009 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Sep 9 23:42:40.111208 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 9 23:42:40.139924 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 9 23:42:40.168317 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Sep 9 23:42:40.174769 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Sep 9 23:42:40.179553 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 23:42:40.190902 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 23:42:40.196220 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 23:42:40.207930 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 9 23:42:40.221117 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 9 23:42:40.240028 disk-uuid[687]: Primary Header is updated. Sep 9 23:42:40.240028 disk-uuid[687]: Secondary Entries is updated. Sep 9 23:42:40.240028 disk-uuid[687]: Secondary Header is updated. Sep 9 23:42:40.259507 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 9 23:42:40.301274 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 9 23:42:41.281597 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 9 23:42:41.283383 disk-uuid[688]: The operation has completed successfully. Sep 9 23:42:41.474841 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 9 23:42:41.475446 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 9 23:42:41.565954 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 9 23:42:41.600380 sh[955]: Success Sep 9 23:42:41.631440 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 9 23:42:41.631541 kernel: device-mapper: uevent: version 1.0.3 Sep 9 23:42:41.633667 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 9 23:42:41.647344 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 9 23:42:41.746672 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 9 23:42:41.753970 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 9 23:42:41.781146 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 9 23:42:41.801334 kernel: BTRFS: device fsid 2bc16190-0dd5-44d6-b331-3d703f5a1d1f devid 1 transid 40 /dev/mapper/usr (254:0) scanned by mount (978) Sep 9 23:42:41.805234 kernel: BTRFS info (device dm-0): first mount of filesystem 2bc16190-0dd5-44d6-b331-3d703f5a1d1f Sep 9 23:42:41.805424 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:42:41.948726 kernel: BTRFS info (device dm-0): enabling ssd optimizations Sep 9 23:42:41.948813 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 9 23:42:41.948840 kernel: BTRFS info (device dm-0): enabling free space tree Sep 9 23:42:41.974200 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 9 23:42:41.974729 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 9 23:42:41.981581 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 9 23:42:41.982938 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 9 23:42:41.989676 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 9 23:42:42.057344 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:3) scanned by mount (1017) Sep 9 23:42:42.062337 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 3a7d3e29-58a5-4f0c-ac69-b528108338f5 Sep 9 23:42:42.062415 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:42:42.079605 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 9 23:42:42.079694 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 9 23:42:42.088397 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 3a7d3e29-58a5-4f0c-ac69-b528108338f5 Sep 9 23:42:42.090737 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 9 23:42:42.102890 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 9 23:42:42.190910 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 23:42:42.201612 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 9 23:42:42.273244 systemd-networkd[1147]: lo: Link UP Sep 9 23:42:42.273335 systemd-networkd[1147]: lo: Gained carrier Sep 9 23:42:42.275694 systemd-networkd[1147]: Enumeration completed Sep 9 23:42:42.277178 systemd-networkd[1147]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:42:42.277185 systemd-networkd[1147]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 23:42:42.278653 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 9 23:42:42.287576 systemd[1]: Reached target network.target - Network. Sep 9 23:42:42.296359 systemd-networkd[1147]: eth0: Link UP Sep 9 23:42:42.296366 systemd-networkd[1147]: eth0: Gained carrier Sep 9 23:42:42.296387 systemd-networkd[1147]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:42:42.332375 systemd-networkd[1147]: eth0: DHCPv4 address 172.31.25.217/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 9 23:42:42.826667 ignition[1084]: Ignition 2.21.0 Sep 9 23:42:42.826703 ignition[1084]: Stage: fetch-offline Sep 9 23:42:42.827670 ignition[1084]: no configs at "/usr/lib/ignition/base.d" Sep 9 23:42:42.827696 ignition[1084]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 9 23:42:42.828793 ignition[1084]: Ignition finished successfully Sep 9 23:42:42.843393 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 23:42:42.849457 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 9 23:42:42.895670 ignition[1158]: Ignition 2.21.0 Sep 9 23:42:42.896201 ignition[1158]: Stage: fetch Sep 9 23:42:42.897312 ignition[1158]: no configs at "/usr/lib/ignition/base.d" Sep 9 23:42:42.897344 ignition[1158]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 9 23:42:42.897653 ignition[1158]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 9 23:42:42.913516 ignition[1158]: PUT result: OK Sep 9 23:42:42.923914 ignition[1158]: parsed url from cmdline: "" Sep 9 23:42:42.924077 ignition[1158]: no config URL provided Sep 9 23:42:42.924273 ignition[1158]: reading system config file "/usr/lib/ignition/user.ign" Sep 9 23:42:42.924331 ignition[1158]: no config at "/usr/lib/ignition/user.ign" Sep 9 23:42:42.924371 ignition[1158]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 9 23:42:42.939683 ignition[1158]: PUT result: OK Sep 9 23:42:42.940088 ignition[1158]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Sep 9 23:42:42.947705 ignition[1158]: GET result: OK Sep 9 23:42:42.948066 ignition[1158]: parsing config with SHA512: 8dab42292eafa6bd345f37b2c1fc645745609878105dbb1838798bee94b33b53498a4533b9cca3ee7d69739d8b04a898ca335ee47d6871c9837a6ad050dcfe1c Sep 9 23:42:42.957522 unknown[1158]: fetched base config from "system" Sep 9 23:42:42.957555 unknown[1158]: fetched base config from "system" Sep 9 23:42:42.957919 ignition[1158]: fetch: fetch complete Sep 9 23:42:42.957594 unknown[1158]: fetched user config from "aws" Sep 9 23:42:42.961744 ignition[1158]: fetch: fetch passed Sep 9 23:42:42.961879 ignition[1158]: Ignition finished successfully Sep 9 23:42:42.975675 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 9 23:42:42.981436 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 9 23:42:43.032366 ignition[1165]: Ignition 2.21.0 Sep 9 23:42:43.032397 ignition[1165]: Stage: kargs Sep 9 23:42:43.032913 ignition[1165]: no configs at "/usr/lib/ignition/base.d" Sep 9 23:42:43.032938 ignition[1165]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 9 23:42:43.033081 ignition[1165]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 9 23:42:43.040197 ignition[1165]: PUT result: OK Sep 9 23:42:43.052687 ignition[1165]: kargs: kargs passed Sep 9 23:42:43.052805 ignition[1165]: Ignition finished successfully Sep 9 23:42:43.057148 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 9 23:42:43.064860 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 9 23:42:43.108011 ignition[1172]: Ignition 2.21.0 Sep 9 23:42:43.111551 ignition[1172]: Stage: disks Sep 9 23:42:43.112500 ignition[1172]: no configs at "/usr/lib/ignition/base.d" Sep 9 23:42:43.112526 ignition[1172]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 9 23:42:43.112750 ignition[1172]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 9 23:42:43.127731 ignition[1172]: PUT result: OK Sep 9 23:42:43.133456 ignition[1172]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Sep 9 23:42:43.146266 ignition[1172]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Sep 9 23:42:43.150610 ignition[1172]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/nvme0n1p9" Sep 9 23:42:43.154194 ignition[1172]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Sep 9 23:42:43.192220 ignition[1172]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Sep 9 23:42:43.192258 ignition[1172]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "7cc0d7f3-e4a1-4dc4-8b58-ceece0d874c1" and label "ROOT" Sep 9 23:42:43.192270 ignition[1172]: disks: createFilesystems: filesystem at "/dev/disk/by-partlabel/ROOT" is already correctly formatted. Skipping mkfs... Sep 9 23:42:43.192316 ignition[1172]: disks: disks passed Sep 9 23:42:43.192440 ignition[1172]: Ignition finished successfully Sep 9 23:42:43.214239 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 9 23:42:43.223277 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 9 23:42:43.229522 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 9 23:42:43.235314 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 23:42:43.238819 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 23:42:43.246224 systemd[1]: Reached target basic.target - Basic System. Sep 9 23:42:43.251165 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 9 23:42:43.304766 systemd-fsck[1180]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 9 23:42:43.315127 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 9 23:42:43.324440 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 9 23:42:43.456326 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 7cc0d7f3-e4a1-4dc4-8b58-ceece0d874c1 r/w with ordered data mode. Quota mode: none. Sep 9 23:42:43.457320 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 9 23:42:43.460161 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 9 23:42:43.470104 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 23:42:43.476634 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 9 23:42:43.487886 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 9 23:42:43.487996 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 9 23:42:43.488047 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 23:42:43.509998 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 9 23:42:43.513232 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 9 23:42:43.534367 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:3) scanned by mount (1199) Sep 9 23:42:43.538166 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 3a7d3e29-58a5-4f0c-ac69-b528108338f5 Sep 9 23:42:43.538208 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:42:43.545422 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 9 23:42:43.545492 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 9 23:42:43.548205 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 23:42:43.607475 systemd-networkd[1147]: eth0: Gained IPv6LL Sep 9 23:42:43.980307 initrd-setup-root[1223]: cut: /sysroot/etc/passwd: No such file or directory Sep 9 23:42:44.052424 initrd-setup-root[1230]: cut: /sysroot/etc/group: No such file or directory Sep 9 23:42:44.063098 initrd-setup-root[1237]: cut: /sysroot/etc/shadow: No such file or directory Sep 9 23:42:44.073334 initrd-setup-root[1244]: cut: /sysroot/etc/gshadow: No such file or directory Sep 9 23:42:44.534506 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 9 23:42:44.543639 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 9 23:42:44.548784 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 9 23:42:44.582909 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 9 23:42:44.586433 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 3a7d3e29-58a5-4f0c-ac69-b528108338f5 Sep 9 23:42:44.622386 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 9 23:42:44.643763 ignition[1312]: INFO : Ignition 2.21.0 Sep 9 23:42:44.643763 ignition[1312]: INFO : Stage: mount Sep 9 23:42:44.651217 ignition[1312]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 23:42:44.651217 ignition[1312]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 9 23:42:44.651217 ignition[1312]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 9 23:42:44.661249 ignition[1312]: INFO : PUT result: OK Sep 9 23:42:44.671566 ignition[1312]: INFO : mount: op(1): [started] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Sep 9 23:42:44.671566 ignition[1312]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "ext4" "/dev/disk/by-partlabel/ROOT" "/sysroot/tmp/_translate-filesystem-0-ign1" Sep 9 23:42:44.692578 ignition[1312]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Sep 9 23:42:44.692578 ignition[1312]: INFO : mount: mount passed Sep 9 23:42:44.692578 ignition[1312]: INFO : Ignition finished successfully Sep 9 23:42:44.703669 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 9 23:42:44.711490 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 9 23:42:44.743203 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 23:42:44.796332 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:3) scanned by mount (1326) Sep 9 23:42:44.801139 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 3a7d3e29-58a5-4f0c-ac69-b528108338f5 Sep 9 23:42:44.801224 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:42:44.809056 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 9 23:42:44.809131 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 9 23:42:44.812581 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 23:42:44.864355 ignition[1343]: INFO : Ignition 2.21.0 Sep 9 23:42:44.864355 ignition[1343]: INFO : Stage: files Sep 9 23:42:44.869379 ignition[1343]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 23:42:44.869379 ignition[1343]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 9 23:42:44.869379 ignition[1343]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 9 23:42:44.879473 ignition[1343]: INFO : PUT result: OK Sep 9 23:42:44.886455 ignition[1343]: DEBUG : files: compiled without relabeling support, skipping Sep 9 23:42:44.897225 ignition[1343]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 9 23:42:44.897225 ignition[1343]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 9 23:42:44.910936 ignition[1343]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 9 23:42:44.915453 ignition[1343]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 9 23:42:44.920459 unknown[1343]: wrote ssh authorized keys file for user: core Sep 9 23:42:44.923300 ignition[1343]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 9 23:42:44.932976 ignition[1343]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Sep 9 23:42:44.938695 ignition[1343]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Sep 9 23:42:44.938695 ignition[1343]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Sep 9 23:42:44.938695 ignition[1343]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Sep 9 23:42:44.938695 ignition[1343]: INFO : files: op(5): [started] processing unit "metadata.target" Sep 9 23:42:44.938695 ignition[1343]: INFO : files: op(5): op(6): [started] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Sep 9 23:42:44.962689 ignition[1343]: INFO : files: op(5): op(6): [finished] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Sep 9 23:42:44.962689 ignition[1343]: INFO : files: op(5): [finished] processing unit "metadata.target" Sep 9 23:42:44.962689 ignition[1343]: INFO : files: op(7): [started] setting preset to enabled for "coreos-metadata.service" Sep 9 23:42:44.962689 ignition[1343]: INFO : files: op(7): [finished] setting preset to enabled for "coreos-metadata.service" Sep 9 23:42:44.962689 ignition[1343]: INFO : files: op(8): [started] setting preset to enabled for "metadata.target" Sep 9 23:42:44.962689 ignition[1343]: INFO : files: op(8): [finished] setting preset to enabled for "metadata.target" Sep 9 23:42:44.962689 ignition[1343]: INFO : files: createResultFile: createFiles: op(9): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 9 23:42:44.962689 ignition[1343]: INFO : files: createResultFile: createFiles: op(9): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 9 23:42:44.962689 ignition[1343]: INFO : files: files passed Sep 9 23:42:44.962689 ignition[1343]: INFO : Ignition finished successfully Sep 9 23:42:44.977350 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 9 23:42:44.984762 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 9 23:42:45.028782 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 9 23:42:45.041467 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 9 23:42:45.045386 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 9 23:42:45.085661 initrd-setup-root-after-ignition[1372]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 23:42:45.085661 initrd-setup-root-after-ignition[1372]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 9 23:42:45.094425 initrd-setup-root-after-ignition[1375]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 23:42:45.097022 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 23:42:45.105538 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 9 23:42:45.112527 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 9 23:42:45.224136 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 9 23:42:45.224454 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 9 23:42:45.230180 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 9 23:42:45.232959 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 9 23:42:45.239562 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 9 23:42:45.241011 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 9 23:42:45.287463 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 23:42:45.294073 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 9 23:42:45.348422 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 9 23:42:45.350384 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 9 23:42:45.358863 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 9 23:42:45.365602 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 23:42:45.368904 systemd[1]: Stopped target timers.target - Timer Units. Sep 9 23:42:45.371691 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 9 23:42:45.371832 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 23:42:45.394263 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 9 23:42:45.399608 systemd[1]: Stopped target basic.target - Basic System. Sep 9 23:42:45.402190 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 9 23:42:45.414936 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 23:42:45.420945 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 9 23:42:45.421239 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 9 23:42:45.432486 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 9 23:42:45.435070 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 23:42:45.439968 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 9 23:42:45.449499 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 9 23:42:45.452640 systemd[1]: Stopped target swap.target - Swaps. Sep 9 23:42:45.460442 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 9 23:42:45.460571 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 9 23:42:45.469832 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 9 23:42:45.475056 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 23:42:45.484255 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 9 23:42:45.484634 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 23:42:45.494581 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 9 23:42:45.494713 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 9 23:42:45.503823 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 9 23:42:45.503933 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 23:42:45.507833 systemd[1]: ignition-files.service: Deactivated successfully. Sep 9 23:42:45.507923 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 9 23:42:45.524045 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 9 23:42:45.528024 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 9 23:42:45.535491 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 9 23:42:45.538094 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 23:42:45.547564 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 9 23:42:45.549122 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 23:42:45.594147 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 9 23:42:45.605855 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 9 23:42:45.606379 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 9 23:42:45.619834 ignition[1398]: INFO : Ignition 2.21.0 Sep 9 23:42:45.619834 ignition[1398]: INFO : Stage: umount Sep 9 23:42:45.619834 ignition[1398]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 23:42:45.619834 ignition[1398]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 9 23:42:45.619834 ignition[1398]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 9 23:42:45.619834 ignition[1398]: INFO : PUT result: OK Sep 9 23:42:45.637481 ignition[1398]: INFO : umount: op(1): [started] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Sep 9 23:42:45.642048 ignition[1398]: INFO : umount: op(1): [finished] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Sep 9 23:42:45.642048 ignition[1398]: INFO : umount: umount passed Sep 9 23:42:45.642048 ignition[1398]: INFO : Ignition finished successfully Sep 9 23:42:45.650418 systemd[1]: sysroot-tmp-_translate\x2dfilesystem\x2d0\x2dign1.mount: Deactivated successfully. Sep 9 23:42:45.651424 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 9 23:42:45.651704 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 9 23:42:45.658767 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 9 23:42:45.658911 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 9 23:42:45.662049 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 9 23:42:45.662154 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 9 23:42:45.665193 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 9 23:42:45.665369 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 9 23:42:45.671867 systemd[1]: Stopped target network.target - Network. Sep 9 23:42:45.674472 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 9 23:42:45.674600 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 23:42:45.678416 systemd[1]: Stopped target paths.target - Path Units. Sep 9 23:42:45.682612 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 9 23:42:45.701552 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 23:42:45.704963 systemd[1]: Stopped target slices.target - Slice Units. Sep 9 23:42:45.707881 systemd[1]: Stopped target sockets.target - Socket Units. Sep 9 23:42:45.711237 systemd[1]: iscsid.socket: Deactivated successfully. Sep 9 23:42:45.711376 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 23:42:45.718674 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 9 23:42:45.718758 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 23:42:45.724434 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 9 23:42:45.724548 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 9 23:42:45.727786 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 9 23:42:45.727890 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 9 23:42:45.737202 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 9 23:42:45.737357 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 9 23:42:45.741310 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 9 23:42:45.752213 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 9 23:42:45.794502 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 9 23:42:45.794748 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 9 23:42:45.807850 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 9 23:42:45.808708 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 9 23:42:45.808920 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 9 23:42:45.824779 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Sep 9 23:42:45.825876 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 9 23:42:45.830773 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 9 23:42:45.830862 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 9 23:42:45.842134 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 9 23:42:45.850143 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 9 23:42:45.850870 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 23:42:45.865250 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 9 23:42:45.865391 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 9 23:42:45.874251 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 9 23:42:45.874712 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 9 23:42:45.879485 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 9 23:42:45.879607 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 23:42:45.893464 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 23:42:45.900692 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Sep 9 23:42:45.900831 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Sep 9 23:42:45.926512 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 9 23:42:45.926720 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 9 23:42:45.942840 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 9 23:42:45.945558 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 23:42:45.952441 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 9 23:42:45.952559 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 9 23:42:45.960180 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 9 23:42:45.960274 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 23:42:45.963012 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 9 23:42:45.963119 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 9 23:42:45.969136 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 9 23:42:45.969250 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 9 23:42:45.976799 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 9 23:42:45.976917 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 23:42:45.987044 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 9 23:42:46.001645 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 9 23:42:46.001772 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 23:42:46.011595 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 9 23:42:46.011712 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 23:42:46.017934 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 9 23:42:46.018032 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 23:42:46.031547 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 9 23:42:46.031657 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 23:42:46.038430 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 23:42:46.038539 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:42:46.058486 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 9 23:42:46.058835 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 9 23:42:46.066186 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 9 23:42:46.075151 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 9 23:42:46.107743 systemd[1]: Switching root. Sep 9 23:42:46.176105 systemd-journald[257]: Journal stopped Sep 9 23:42:49.098172 systemd-journald[257]: Received SIGTERM from PID 1 (systemd). Sep 9 23:42:49.098333 kernel: SELinux: policy capability network_peer_controls=1 Sep 9 23:42:49.098382 kernel: SELinux: policy capability open_perms=1 Sep 9 23:42:49.098415 kernel: SELinux: policy capability extended_socket_class=1 Sep 9 23:42:49.098447 kernel: SELinux: policy capability always_check_network=0 Sep 9 23:42:49.098478 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 9 23:42:49.098510 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 9 23:42:49.098554 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 9 23:42:49.098585 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 9 23:42:49.098643 kernel: SELinux: policy capability userspace_initial_context=0 Sep 9 23:42:49.098695 kernel: audit: type=1403 audit(1757461366.582:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 9 23:42:49.098752 systemd[1]: Successfully loaded SELinux policy in 154.922ms. Sep 9 23:42:49.098854 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 15.697ms. Sep 9 23:42:49.099010 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 9 23:42:49.099066 systemd[1]: Detected virtualization amazon. Sep 9 23:42:49.099129 systemd[1]: Detected architecture arm64. Sep 9 23:42:49.099210 systemd[1]: Detected first boot. Sep 9 23:42:49.099270 systemd[1]: Initializing machine ID from VM UUID. Sep 9 23:42:49.099356 kernel: NET: Registered PF_VSOCK protocol family Sep 9 23:42:49.099435 zram_generator::config[1440]: No configuration found. Sep 9 23:42:49.099476 systemd[1]: Populated /etc with preset unit settings. Sep 9 23:42:49.099551 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 9 23:42:49.099619 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 9 23:42:49.099679 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 9 23:42:49.099754 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 9 23:42:49.099809 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 9 23:42:49.099856 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 9 23:42:49.099918 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 9 23:42:49.099986 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 9 23:42:49.100059 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 9 23:42:49.100144 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 9 23:42:49.100205 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 9 23:42:49.100237 systemd[1]: Created slice user.slice - User and Session Slice. Sep 9 23:42:49.100325 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 23:42:49.100387 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 23:42:49.100445 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 9 23:42:49.100510 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 9 23:42:49.100567 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 9 23:42:49.100614 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 23:42:49.100667 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 9 23:42:49.100739 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 23:42:49.100807 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 23:42:49.100870 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 9 23:42:49.100931 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 9 23:42:49.100987 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 9 23:42:49.101038 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 9 23:42:49.101139 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 23:42:49.104354 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 23:42:49.104432 systemd[1]: Reached target slices.target - Slice Units. Sep 9 23:42:49.104474 systemd[1]: Reached target swap.target - Swaps. Sep 9 23:42:49.104515 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 9 23:42:49.104545 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 9 23:42:49.104576 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 9 23:42:49.104608 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 9 23:42:49.104639 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 23:42:49.104670 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 23:42:49.104705 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 9 23:42:49.104736 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 9 23:42:49.104764 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 9 23:42:49.104897 systemd[1]: Mounting media.mount - External Media Directory... Sep 9 23:42:49.104938 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 9 23:42:49.104967 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 9 23:42:49.104999 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Sep 9 23:42:49.105029 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 9 23:42:49.105061 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 9 23:42:49.105091 systemd[1]: Reached target machines.target - Containers. Sep 9 23:42:49.105120 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 9 23:42:49.105156 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:42:49.105186 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 23:42:49.105224 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 9 23:42:49.105258 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 23:42:49.105318 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 9 23:42:49.105355 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 23:42:49.105389 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 9 23:42:49.105420 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 23:42:49.105450 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 9 23:42:49.105489 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 9 23:42:49.105529 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 9 23:42:49.105560 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 9 23:42:49.105590 systemd[1]: Stopped systemd-fsck-usr.service. Sep 9 23:42:49.105621 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 23:42:49.105649 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 23:42:49.105677 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 23:42:49.105706 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 9 23:42:49.105739 kernel: fuse: init (API version 7.41) Sep 9 23:42:49.105770 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 9 23:42:49.105798 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 9 23:42:49.105826 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 23:42:49.105859 systemd[1]: verity-setup.service: Deactivated successfully. Sep 9 23:42:49.105892 systemd[1]: Stopped verity-setup.service. Sep 9 23:42:49.105938 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 9 23:42:49.105972 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 9 23:42:49.106001 systemd[1]: Mounted media.mount - External Media Directory. Sep 9 23:42:49.106032 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 9 23:42:49.106062 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 9 23:42:49.106095 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 9 23:42:49.106124 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 23:42:49.106152 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 9 23:42:49.106180 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 9 23:42:49.106208 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 23:42:49.106238 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 23:42:49.106267 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 23:42:49.106330 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 23:42:49.106372 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 9 23:42:49.106401 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 9 23:42:49.106430 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 9 23:42:49.106459 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 9 23:42:49.106488 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 9 23:42:49.106583 systemd-journald[1516]: Collecting audit messages is disabled. Sep 9 23:42:49.106643 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 23:42:49.106672 systemd-journald[1516]: Journal started Sep 9 23:42:49.106728 systemd-journald[1516]: Runtime Journal (/run/log/journal/ec21b1aade41d152bfc0d69fa95bc640) is 8M, max 75.3M, 67.3M free. Sep 9 23:42:48.401719 systemd[1]: Queued start job for default target multi-user.target. Sep 9 23:42:48.425567 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Sep 9 23:42:48.426433 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 9 23:42:49.117142 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 9 23:42:49.123500 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 23:42:49.123601 kernel: loop: module loaded Sep 9 23:42:49.125432 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 9 23:42:49.129404 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 9 23:42:49.142976 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 23:42:49.144209 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 23:42:49.173805 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 9 23:42:49.173923 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 23:42:49.180259 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 9 23:42:49.192708 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 9 23:42:49.195875 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:42:49.212444 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 9 23:42:49.221813 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 9 23:42:49.225408 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 23:42:49.227685 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 9 23:42:49.230575 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 9 23:42:49.239958 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 23:42:49.260987 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 9 23:42:49.269443 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 23:42:49.277401 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 9 23:42:49.285033 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 9 23:42:49.315573 kernel: ACPI: bus type drm_connector registered Sep 9 23:42:49.315628 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 9 23:42:49.328183 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 23:42:49.332446 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 9 23:42:49.353479 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 9 23:42:49.357514 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 9 23:42:49.364723 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 9 23:42:49.383102 systemd-journald[1516]: Time spent on flushing to /var/log/journal/ec21b1aade41d152bfc0d69fa95bc640 is 147.075ms for 933 entries. Sep 9 23:42:49.383102 systemd-journald[1516]: System Journal (/var/log/journal/ec21b1aade41d152bfc0d69fa95bc640) is 8M, max 195.6M, 187.6M free. Sep 9 23:42:49.547997 systemd-journald[1516]: Received client request to flush runtime journal. Sep 9 23:42:49.548081 kernel: loop0: detected capacity change from 0 to 100608 Sep 9 23:42:49.385806 systemd-tmpfiles[1544]: ACLs are not supported, ignoring. Sep 9 23:42:49.385832 systemd-tmpfiles[1544]: ACLs are not supported, ignoring. Sep 9 23:42:49.410682 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 23:42:49.421916 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 9 23:42:49.462350 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 23:42:49.487117 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 9 23:42:49.491402 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 9 23:42:49.555778 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 9 23:42:49.594625 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 9 23:42:49.603131 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 23:42:49.620328 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 9 23:42:49.658395 kernel: loop1: detected capacity change from 0 to 119320 Sep 9 23:42:49.683255 systemd-tmpfiles[1593]: ACLs are not supported, ignoring. Sep 9 23:42:49.685118 systemd-tmpfiles[1593]: ACLs are not supported, ignoring. Sep 9 23:42:49.703463 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 23:42:49.710449 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 23:42:49.768350 kernel: loop2: detected capacity change from 0 to 61256 Sep 9 23:42:49.879324 kernel: loop3: detected capacity change from 0 to 100608 Sep 9 23:42:49.907337 kernel: loop4: detected capacity change from 0 to 119320 Sep 9 23:42:49.927344 kernel: loop5: detected capacity change from 0 to 61256 Sep 9 23:42:49.940187 (sd-merge)[1599]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Sep 9 23:42:49.941259 (sd-merge)[1599]: Merged extensions into '/usr'. Sep 9 23:42:49.953497 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 9 23:42:49.961665 systemd[1]: Starting ensure-sysext.service... Sep 9 23:42:49.969816 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 23:42:50.011870 systemd[1]: Reload requested from client PID 1601 ('systemctl') (unit ensure-sysext.service)... Sep 9 23:42:50.012053 systemd[1]: Reloading... Sep 9 23:42:50.099112 systemd-tmpfiles[1602]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 9 23:42:50.102469 systemd-tmpfiles[1602]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 9 23:42:50.105128 systemd-tmpfiles[1602]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 9 23:42:50.108957 systemd-tmpfiles[1602]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 9 23:42:50.117084 systemd-tmpfiles[1602]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 9 23:42:50.121956 systemd-tmpfiles[1602]: ACLs are not supported, ignoring. Sep 9 23:42:50.122465 systemd-tmpfiles[1602]: ACLs are not supported, ignoring. Sep 9 23:42:50.143010 systemd-tmpfiles[1602]: Detected autofs mount point /boot during canonicalization of boot. Sep 9 23:42:50.143037 systemd-tmpfiles[1602]: Skipping /boot Sep 9 23:42:50.207717 systemd-tmpfiles[1602]: Detected autofs mount point /boot during canonicalization of boot. Sep 9 23:42:50.207751 systemd-tmpfiles[1602]: Skipping /boot Sep 9 23:42:50.243325 zram_generator::config[1635]: No configuration found. Sep 9 23:42:50.761251 systemd[1]: Reloading finished in 748 ms. Sep 9 23:42:50.790452 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 9 23:42:50.827577 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 23:42:50.843233 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 9 23:42:50.852215 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 9 23:42:50.864199 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 9 23:42:50.880414 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 23:42:50.889690 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 23:42:50.905819 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 9 23:42:50.922616 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:42:50.927383 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 23:42:50.938399 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 23:42:50.957451 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 23:42:50.960979 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:42:50.961319 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 23:42:50.971081 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:42:50.972092 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:42:50.972422 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 23:42:50.984269 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:42:50.995867 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 9 23:42:50.998876 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:42:50.999154 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 23:42:50.999660 systemd[1]: Reached target time-set.target - System Time Set. Sep 9 23:42:51.017771 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 9 23:42:51.022356 systemd[1]: Finished ensure-sysext.service. Sep 9 23:42:51.029961 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 9 23:42:51.034983 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 9 23:42:51.094658 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 23:42:51.096418 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 23:42:51.100710 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 23:42:51.119056 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 23:42:51.122516 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 23:42:51.128725 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 23:42:51.131536 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 23:42:51.146590 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 23:42:51.147101 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 9 23:42:51.158639 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 9 23:42:51.204720 systemd-udevd[1687]: Using default interface naming scheme 'v255'. Sep 9 23:42:51.218543 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 9 23:42:51.225675 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 9 23:42:51.261748 augenrules[1721]: No rules Sep 9 23:42:51.265978 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 23:42:51.266580 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 9 23:42:51.277698 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 9 23:42:51.321229 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 23:42:51.342593 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 9 23:42:51.603706 systemd-resolved[1686]: Positive Trust Anchors: Sep 9 23:42:51.603748 systemd-resolved[1686]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 23:42:51.603811 systemd-resolved[1686]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 9 23:42:51.631781 systemd-resolved[1686]: Defaulting to hostname 'linux'. Sep 9 23:42:51.647135 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 23:42:51.653924 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 23:42:51.702562 (udev-worker)[1758]: Network interface NamePolicy= disabled on kernel command line. Sep 9 23:42:51.707829 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 9 23:42:51.878613 systemd-networkd[1739]: lo: Link UP Sep 9 23:42:51.878647 systemd-networkd[1739]: lo: Gained carrier Sep 9 23:42:51.884375 systemd-networkd[1739]: Enumeration completed Sep 9 23:42:51.884619 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 9 23:42:51.891663 systemd[1]: Reached target network.target - Network. Sep 9 23:42:51.907763 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 9 23:42:51.916621 systemd-networkd[1739]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:42:51.916653 systemd-networkd[1739]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 23:42:51.918847 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 9 23:42:51.938241 ldconfig[1565]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 9 23:42:51.942566 systemd-networkd[1739]: eth0: Link UP Sep 9 23:42:51.942964 systemd-networkd[1739]: eth0: Gained carrier Sep 9 23:42:51.943004 systemd-networkd[1739]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:42:51.953030 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 9 23:42:51.968488 systemd-networkd[1739]: eth0: DHCPv4 address 172.31.25.217/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 9 23:42:51.969363 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 9 23:42:51.984141 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 9 23:42:52.021249 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 9 23:42:52.030482 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 23:42:52.040155 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 9 23:42:52.045431 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 9 23:42:52.057646 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 9 23:42:52.063472 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 9 23:42:52.075988 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 9 23:42:52.082839 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 9 23:42:52.082921 systemd[1]: Reached target paths.target - Path Units. Sep 9 23:42:52.087925 systemd[1]: Reached target timers.target - Timer Units. Sep 9 23:42:52.098461 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 9 23:42:52.110071 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 23:42:52.124979 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 9 23:42:52.131984 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 9 23:42:52.136912 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 9 23:42:52.150527 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 9 23:42:52.157708 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 9 23:42:52.164761 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 23:42:52.170130 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 23:42:52.174055 systemd[1]: Reached target basic.target - Basic System. Sep 9 23:42:52.178460 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 9 23:42:52.178532 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 9 23:42:52.183844 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 23:42:52.193404 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Sep 9 23:42:52.203801 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 9 23:42:52.248740 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 9 23:42:52.257736 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 9 23:42:52.270854 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 9 23:42:52.275942 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Sep 9 23:42:52.279999 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 9 23:42:52.291217 systemd[1]: Started ntpd.service - Network Time Service. Sep 9 23:42:52.299447 systemd[1]: Starting setup-oem.service - Setup OEM... Sep 9 23:42:52.309773 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 9 23:42:52.322040 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 9 23:42:52.346764 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 9 23:42:52.361399 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 9 23:42:52.373279 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 9 23:42:52.382737 systemd[1]: Starting update-engine.service - Update Engine... Sep 9 23:42:52.393433 jq[1859]: false Sep 9 23:42:52.401640 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 9 23:42:52.419493 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 9 23:42:52.426542 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 9 23:42:52.428437 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 9 23:42:52.535429 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 9 23:42:52.537440 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 9 23:42:52.596717 (ntainerd)[1885]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 23:42:52.649387 jq[1878]: true Sep 9 23:42:52.666518 extend-filesystems[1860]: Found /dev/nvme0n1p6 Sep 9 23:42:52.670758 systemd[1]: motdgen.service: Deactivated successfully. Sep 9 23:42:52.672360 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 9 23:42:52.691671 extend-filesystems[1860]: Found /dev/nvme0n1p9 Sep 9 23:42:52.692068 dbus-daemon[1844]: [system] SELinux support is enabled Sep 9 23:42:52.692413 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 9 23:42:52.706490 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Sep 9 23:42:52.706579 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 9 23:42:52.706834 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 9 23:42:52.706867 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 9 23:42:52.728833 dbus-daemon[1844]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1739 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Sep 9 23:42:52.740024 extend-filesystems[1860]: Checking size of /dev/nvme0n1p9 Sep 9 23:42:52.757646 dbus-daemon[1844]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 9 23:42:52.766831 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Sep 9 23:42:52.824388 jq[1906]: true Sep 9 23:42:52.844068 update_engine[1875]: I20250909 23:42:52.835732 1875 main.cc:92] Flatcar Update Engine starting Sep 9 23:42:52.853317 update_engine[1875]: I20250909 23:42:52.851615 1875 update_check_scheduler.cc:74] Next update check in 10m48s Sep 9 23:42:52.874086 extend-filesystems[1860]: Resized partition /dev/nvme0n1p9 Sep 9 23:42:52.927521 coreos-metadata[1843]: Sep 09 23:42:52.927 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 9 23:42:52.931649 ntpd[1863]: ntpd 4.2.8p17@1.4004-o Tue Sep 9 21:32:21 UTC 2025 (1): Starting Sep 9 23:42:52.933935 extend-filesystems[1925]: resize2fs 1.47.2 (1-Jan-2025) Sep 9 23:42:52.938499 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: ntpd 4.2.8p17@1.4004-o Tue Sep 9 21:32:21 UTC 2025 (1): Starting Sep 9 23:42:52.938499 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 9 23:42:52.938499 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: ---------------------------------------------------- Sep 9 23:42:52.938499 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: ntp-4 is maintained by Network Time Foundation, Sep 9 23:42:52.938499 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 9 23:42:52.938499 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: corporation. Support and training for ntp-4 are Sep 9 23:42:52.938499 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: available at https://www.nwtime.org/support Sep 9 23:42:52.938499 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: ---------------------------------------------------- Sep 9 23:42:52.931719 ntpd[1863]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 9 23:42:52.939560 coreos-metadata[1843]: Sep 09 23:42:52.938 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Sep 9 23:42:52.931739 ntpd[1863]: ---------------------------------------------------- Sep 9 23:42:52.931756 ntpd[1863]: ntp-4 is maintained by Network Time Foundation, Sep 9 23:42:52.931774 ntpd[1863]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 9 23:42:52.931790 ntpd[1863]: corporation. Support and training for ntp-4 are Sep 9 23:42:52.931806 ntpd[1863]: available at https://www.nwtime.org/support Sep 9 23:42:52.931822 ntpd[1863]: ---------------------------------------------------- Sep 9 23:42:52.944191 ntpd[1863]: proto: precision = 0.096 usec (-23) Sep 9 23:42:52.945578 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: proto: precision = 0.096 usec (-23) Sep 9 23:42:52.945635 coreos-metadata[1843]: Sep 09 23:42:52.942 INFO Fetch successful Sep 9 23:42:52.945635 coreos-metadata[1843]: Sep 09 23:42:52.942 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Sep 9 23:42:52.946920 coreos-metadata[1843]: Sep 09 23:42:52.946 INFO Fetch successful Sep 9 23:42:52.946920 coreos-metadata[1843]: Sep 09 23:42:52.946 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Sep 9 23:42:52.947971 ntpd[1863]: basedate set to 2025-08-28 Sep 9 23:42:52.950461 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: basedate set to 2025-08-28 Sep 9 23:42:52.950461 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: gps base set to 2025-08-31 (week 2382) Sep 9 23:42:52.948020 ntpd[1863]: gps base set to 2025-08-31 (week 2382) Sep 9 23:42:52.955862 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Sep 9 23:42:52.955983 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: Listen and drop on 0 v6wildcard [::]:123 Sep 9 23:42:52.955983 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 9 23:42:52.955672 ntpd[1863]: Listen and drop on 0 v6wildcard [::]:123 Sep 9 23:42:52.956145 coreos-metadata[1843]: Sep 09 23:42:52.953 INFO Fetch successful Sep 9 23:42:52.956145 coreos-metadata[1843]: Sep 09 23:42:52.953 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Sep 9 23:42:52.955761 ntpd[1863]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 9 23:42:52.957066 coreos-metadata[1843]: Sep 09 23:42:52.956 INFO Fetch successful Sep 9 23:42:52.957066 coreos-metadata[1843]: Sep 09 23:42:52.957 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Sep 9 23:42:52.959318 coreos-metadata[1843]: Sep 09 23:42:52.957 INFO Fetch failed with 404: resource not found Sep 9 23:42:52.959318 coreos-metadata[1843]: Sep 09 23:42:52.957 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Sep 9 23:42:52.959857 coreos-metadata[1843]: Sep 09 23:42:52.959 INFO Fetch successful Sep 9 23:42:52.959857 coreos-metadata[1843]: Sep 09 23:42:52.959 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Sep 9 23:42:52.962585 ntpd[1863]: Listen normally on 2 lo 127.0.0.1:123 Sep 9 23:42:52.962708 ntpd[1863]: Listen normally on 3 eth0 172.31.25.217:123 Sep 9 23:42:52.962797 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: Listen normally on 2 lo 127.0.0.1:123 Sep 9 23:42:52.962797 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: Listen normally on 3 eth0 172.31.25.217:123 Sep 9 23:42:52.962795 ntpd[1863]: Listen normally on 4 lo [::1]:123 Sep 9 23:42:52.962978 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: Listen normally on 4 lo [::1]:123 Sep 9 23:42:52.962978 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: bind(21) AF_INET6 fe80::451:98ff:fef1:4463%2#123 flags 0x11 failed: Cannot assign requested address Sep 9 23:42:52.962978 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: unable to create socket on eth0 (5) for fe80::451:98ff:fef1:4463%2#123 Sep 9 23:42:52.962978 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: failed to init interface for address fe80::451:98ff:fef1:4463%2 Sep 9 23:42:52.962896 ntpd[1863]: bind(21) AF_INET6 fe80::451:98ff:fef1:4463%2#123 flags 0x11 failed: Cannot assign requested address Sep 9 23:42:52.963212 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: Listening on routing socket on fd #21 for interface updates Sep 9 23:42:52.962936 ntpd[1863]: unable to create socket on eth0 (5) for fe80::451:98ff:fef1:4463%2#123 Sep 9 23:42:52.962961 ntpd[1863]: failed to init interface for address fe80::451:98ff:fef1:4463%2 Sep 9 23:42:52.963021 ntpd[1863]: Listening on routing socket on fd #21 for interface updates Sep 9 23:42:52.965418 coreos-metadata[1843]: Sep 09 23:42:52.965 INFO Fetch successful Sep 9 23:42:52.965418 coreos-metadata[1843]: Sep 09 23:42:52.965 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Sep 9 23:42:52.970453 coreos-metadata[1843]: Sep 09 23:42:52.970 INFO Fetch successful Sep 9 23:42:52.970574 coreos-metadata[1843]: Sep 09 23:42:52.970 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Sep 9 23:42:52.972594 coreos-metadata[1843]: Sep 09 23:42:52.971 INFO Fetch successful Sep 9 23:42:52.972594 coreos-metadata[1843]: Sep 09 23:42:52.971 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Sep 9 23:42:52.976399 coreos-metadata[1843]: Sep 09 23:42:52.976 INFO Fetch successful Sep 9 23:42:52.997451 ntpd[1863]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 9 23:42:52.998536 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 9 23:42:52.998536 ntpd[1863]: 9 Sep 23:42:52 ntpd[1863]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 9 23:42:52.997527 ntpd[1863]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 9 23:42:53.084251 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Sep 9 23:42:53.104430 extend-filesystems[1925]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Sep 9 23:42:53.104430 extend-filesystems[1925]: old_desc_blocks = 1, new_desc_blocks = 1 Sep 9 23:42:53.104430 extend-filesystems[1925]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Sep 9 23:42:53.155532 extend-filesystems[1860]: Resized filesystem in /dev/nvme0n1p9 Sep 9 23:42:53.110043 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 9 23:42:53.125124 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 9 23:42:53.125612 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 9 23:42:53.134349 systemd[1]: Finished setup-oem.service - Setup OEM. Sep 9 23:42:53.140688 systemd[1]: Started update-engine.service - Update Engine. Sep 9 23:42:53.168904 systemd-logind[1874]: New seat seat0. Sep 9 23:42:53.198010 systemd[1]: Started systemd-logind.service - User Login Management. Sep 9 23:42:53.207497 systemd-networkd[1739]: eth0: Gained IPv6LL Sep 9 23:42:53.219421 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 9 23:42:53.226812 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 9 23:42:53.248415 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 9 23:42:53.254887 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 9 23:42:53.262816 systemd[1]: Reached target network-online.target - Network is Online. Sep 9 23:42:53.271191 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Sep 9 23:42:53.279854 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 9 23:42:53.305453 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Sep 9 23:42:53.314429 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 9 23:42:53.324773 systemd[1]: Reached target metadata.target. Sep 9 23:42:53.329018 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 9 23:42:53.409999 bash[1966]: Updated "/home/core/.ssh/authorized_keys" Sep 9 23:42:53.434268 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 9 23:42:53.447507 systemd[1]: Starting sshkeys.service... Sep 9 23:42:53.477402 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 9 23:42:53.507051 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Sep 9 23:42:53.516617 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Sep 9 23:42:53.650335 amazon-ssm-agent[1952]: Initializing new seelog logger Sep 9 23:42:53.653356 amazon-ssm-agent[1952]: New Seelog Logger Creation Complete Sep 9 23:42:53.653356 amazon-ssm-agent[1952]: 2025/09/09 23:42:53 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 9 23:42:53.653356 amazon-ssm-agent[1952]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 9 23:42:53.653356 amazon-ssm-agent[1952]: 2025/09/09 23:42:53 processing appconfig overrides Sep 9 23:42:53.658512 amazon-ssm-agent[1952]: 2025/09/09 23:42:53 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 9 23:42:53.660403 amazon-ssm-agent[1952]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 9 23:42:53.660403 amazon-ssm-agent[1952]: 2025/09/09 23:42:53 processing appconfig overrides Sep 9 23:42:53.660403 amazon-ssm-agent[1952]: 2025/09/09 23:42:53 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 9 23:42:53.660403 amazon-ssm-agent[1952]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 9 23:42:53.660403 amazon-ssm-agent[1952]: 2025/09/09 23:42:53 processing appconfig overrides Sep 9 23:42:53.669597 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.6570 INFO Proxy environment variables: Sep 9 23:42:53.681141 amazon-ssm-agent[1952]: 2025/09/09 23:42:53 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 9 23:42:53.682685 amazon-ssm-agent[1952]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 9 23:42:53.686096 amazon-ssm-agent[1952]: 2025/09/09 23:42:53 processing appconfig overrides Sep 9 23:42:53.741406 containerd[1885]: time="2025-09-09T23:42:53Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 9 23:42:53.750885 containerd[1885]: time="2025-09-09T23:42:53.750779184Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 9 23:42:53.769326 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.6583 INFO https_proxy: Sep 9 23:42:53.822608 containerd[1885]: time="2025-09-09T23:42:53.822509749Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="15.444µs" Sep 9 23:42:53.822608 containerd[1885]: time="2025-09-09T23:42:53.822587077Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 9 23:42:53.822819 containerd[1885]: time="2025-09-09T23:42:53.822664321Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 9 23:42:53.823060 containerd[1885]: time="2025-09-09T23:42:53.822989773Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 9 23:42:53.823134 containerd[1885]: time="2025-09-09T23:42:53.823055845Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 9 23:42:53.823134 containerd[1885]: time="2025-09-09T23:42:53.823118965Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 23:42:53.825361 containerd[1885]: time="2025-09-09T23:42:53.823261669Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 23:42:53.825508 containerd[1885]: time="2025-09-09T23:42:53.825356905Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 9 23:42:53.836647 containerd[1885]: time="2025-09-09T23:42:53.836557165Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 9 23:42:53.836647 containerd[1885]: time="2025-09-09T23:42:53.836626309Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 23:42:53.836804 containerd[1885]: time="2025-09-09T23:42:53.836686873Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 23:42:53.836804 containerd[1885]: time="2025-09-09T23:42:53.836712541Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 9 23:42:53.837010 containerd[1885]: time="2025-09-09T23:42:53.836952325Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 9 23:42:53.841325 containerd[1885]: time="2025-09-09T23:42:53.839744785Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 9 23:42:53.841325 containerd[1885]: time="2025-09-09T23:42:53.839875573Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 9 23:42:53.841325 containerd[1885]: time="2025-09-09T23:42:53.839904565Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 9 23:42:53.841325 containerd[1885]: time="2025-09-09T23:42:53.839965789Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 9 23:42:53.844542 containerd[1885]: time="2025-09-09T23:42:53.844454293Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 9 23:42:53.844726 containerd[1885]: time="2025-09-09T23:42:53.844675417Z" level=info msg="metadata content store policy set" policy=shared Sep 9 23:42:53.853414 containerd[1885]: time="2025-09-09T23:42:53.853324681Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 9 23:42:53.853652 containerd[1885]: time="2025-09-09T23:42:53.853583437Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 9 23:42:53.853726 containerd[1885]: time="2025-09-09T23:42:53.853665613Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 9 23:42:53.853777 containerd[1885]: time="2025-09-09T23:42:53.853700077Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 9 23:42:53.853866 containerd[1885]: time="2025-09-09T23:42:53.853768741Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 9 23:42:53.853866 containerd[1885]: time="2025-09-09T23:42:53.853799785Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 9 23:42:53.853955 containerd[1885]: time="2025-09-09T23:42:53.853864129Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 9 23:42:53.853955 containerd[1885]: time="2025-09-09T23:42:53.853895905Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 9 23:42:53.854036 containerd[1885]: time="2025-09-09T23:42:53.853954933Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 9 23:42:53.854036 containerd[1885]: time="2025-09-09T23:42:53.853983289Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 9 23:42:53.854133 containerd[1885]: time="2025-09-09T23:42:53.854042857Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 9 23:42:53.854133 containerd[1885]: time="2025-09-09T23:42:53.854116609Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 9 23:42:53.855641 containerd[1885]: time="2025-09-09T23:42:53.855553021Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 9 23:42:53.855770 containerd[1885]: time="2025-09-09T23:42:53.855650785Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 9 23:42:53.855770 containerd[1885]: time="2025-09-09T23:42:53.855693145Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 9 23:42:53.855770 containerd[1885]: time="2025-09-09T23:42:53.855722761Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 9 23:42:53.855770 containerd[1885]: time="2025-09-09T23:42:53.855756301Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 9 23:42:53.855962 containerd[1885]: time="2025-09-09T23:42:53.855785641Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 9 23:42:53.855962 containerd[1885]: time="2025-09-09T23:42:53.855813733Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 9 23:42:53.855962 containerd[1885]: time="2025-09-09T23:42:53.855842221Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 9 23:42:53.855962 containerd[1885]: time="2025-09-09T23:42:53.855870445Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 9 23:42:53.855962 containerd[1885]: time="2025-09-09T23:42:53.855898021Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 9 23:42:53.855962 containerd[1885]: time="2025-09-09T23:42:53.855929449Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 9 23:42:53.862314 containerd[1885]: time="2025-09-09T23:42:53.861399661Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 9 23:42:53.862314 containerd[1885]: time="2025-09-09T23:42:53.861535129Z" level=info msg="Start snapshots syncer" Sep 9 23:42:53.862314 containerd[1885]: time="2025-09-09T23:42:53.861636061Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 9 23:42:53.862566 containerd[1885]: time="2025-09-09T23:42:53.862442389Z" 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,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 9 23:42:53.864711 containerd[1885]: time="2025-09-09T23:42:53.864384745Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 9 23:42:53.867904 containerd[1885]: time="2025-09-09T23:42:53.866649337Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 9 23:42:53.867904 containerd[1885]: time="2025-09-09T23:42:53.867104317Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 9 23:42:53.868110 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.6583 INFO http_proxy: Sep 9 23:42:53.869460 containerd[1885]: time="2025-09-09T23:42:53.869379013Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 9 23:42:53.869460 containerd[1885]: time="2025-09-09T23:42:53.869460265Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 9 23:42:53.869636 containerd[1885]: time="2025-09-09T23:42:53.869499001Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 9 23:42:53.869636 containerd[1885]: time="2025-09-09T23:42:53.869531161Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 9 23:42:53.869636 containerd[1885]: time="2025-09-09T23:42:53.869563225Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 9 23:42:53.869636 containerd[1885]: time="2025-09-09T23:42:53.869595889Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 9 23:42:53.869852 containerd[1885]: time="2025-09-09T23:42:53.869659069Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 9 23:42:53.869852 containerd[1885]: time="2025-09-09T23:42:53.869688853Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 9 23:42:53.869852 containerd[1885]: time="2025-09-09T23:42:53.869760733Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 9 23:42:53.869975 containerd[1885]: time="2025-09-09T23:42:53.869856241Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 9 23:42:53.870603 containerd[1885]: time="2025-09-09T23:42:53.870528937Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 9 23:42:53.870603 containerd[1885]: time="2025-09-09T23:42:53.870590773Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 23:42:53.870603 containerd[1885]: time="2025-09-09T23:42:53.870627565Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 23:42:53.870603 containerd[1885]: time="2025-09-09T23:42:53.870649153Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 9 23:42:53.871200 containerd[1885]: time="2025-09-09T23:42:53.870678841Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 9 23:42:53.871200 containerd[1885]: time="2025-09-09T23:42:53.870714265Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 9 23:42:53.871200 containerd[1885]: time="2025-09-09T23:42:53.870888853Z" level=info msg="runtime interface created" Sep 9 23:42:53.871200 containerd[1885]: time="2025-09-09T23:42:53.870908689Z" level=info msg="created NRI interface" Sep 9 23:42:53.871200 containerd[1885]: time="2025-09-09T23:42:53.870934273Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 9 23:42:53.871200 containerd[1885]: time="2025-09-09T23:42:53.870967189Z" level=info msg="Connect containerd service" Sep 9 23:42:53.871200 containerd[1885]: time="2025-09-09T23:42:53.871053037Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 23:42:53.883497 containerd[1885]: time="2025-09-09T23:42:53.882984181Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 9 23:42:53.966206 systemd-logind[1874]: Watching system buttons on /dev/input/event0 (Power Button) Sep 9 23:42:53.966826 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.6583 INFO no_proxy: Sep 9 23:42:53.984613 coreos-metadata[1979]: Sep 09 23:42:53.982 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 9 23:42:53.988776 coreos-metadata[1979]: Sep 09 23:42:53.988 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Sep 9 23:42:53.995593 coreos-metadata[1979]: Sep 09 23:42:53.993 INFO Fetch successful Sep 9 23:42:53.995593 coreos-metadata[1979]: Sep 09 23:42:53.993 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Sep 9 23:42:53.995399 systemd-logind[1874]: Watching system buttons on /dev/input/event1 (Sleep Button) Sep 9 23:42:53.997194 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:42:54.004652 coreos-metadata[1979]: Sep 09 23:42:54.003 INFO Fetch successful Sep 9 23:42:54.013438 unknown[1979]: wrote ssh authorized keys file for user: core Sep 9 23:42:54.066381 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.6596 INFO Checking if agent identity type OnPrem can be assumed Sep 9 23:42:54.079506 update-ssh-keys[2002]: Updated "/home/core/.ssh/authorized_keys" Sep 9 23:42:54.074188 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Sep 9 23:42:54.088275 systemd[1]: Finished sshkeys.service. Sep 9 23:42:54.165756 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.6597 INFO Checking if agent identity type EC2 can be assumed Sep 9 23:42:54.253074 locksmithd[1947]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 9 23:42:54.269720 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.8829 INFO Agent will take identity from EC2 Sep 9 23:42:54.346361 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:42:54.370338 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.8869 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.3.0.0 Sep 9 23:42:54.443628 containerd[1885]: time="2025-09-09T23:42:54.443534640Z" level=info msg="Start subscribing containerd event" Sep 9 23:42:54.443757 containerd[1885]: time="2025-09-09T23:42:54.443643348Z" level=info msg="Start recovering state" Sep 9 23:42:54.443841 containerd[1885]: time="2025-09-09T23:42:54.443798376Z" level=info msg="Start event monitor" Sep 9 23:42:54.443896 containerd[1885]: time="2025-09-09T23:42:54.443838360Z" level=info msg="Start cni network conf syncer for default" Sep 9 23:42:54.443896 containerd[1885]: time="2025-09-09T23:42:54.443860236Z" level=info msg="Start streaming server" Sep 9 23:42:54.443896 containerd[1885]: time="2025-09-09T23:42:54.443881848Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 9 23:42:54.444016 containerd[1885]: time="2025-09-09T23:42:54.443898876Z" level=info msg="runtime interface starting up..." Sep 9 23:42:54.444016 containerd[1885]: time="2025-09-09T23:42:54.443913444Z" level=info msg="starting plugins..." Sep 9 23:42:54.444016 containerd[1885]: time="2025-09-09T23:42:54.443943000Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 9 23:42:54.447599 containerd[1885]: time="2025-09-09T23:42:54.447521748Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 23:42:54.447722 containerd[1885]: time="2025-09-09T23:42:54.447666168Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 23:42:54.452309 containerd[1885]: time="2025-09-09T23:42:54.447810876Z" level=info msg="containerd successfully booted in 0.710405s" Sep 9 23:42:54.449453 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 23:42:54.466322 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.8870 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Sep 9 23:42:54.514463 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Sep 9 23:42:54.526073 dbus-daemon[1844]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 9 23:42:54.532492 dbus-daemon[1844]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=1910 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Sep 9 23:42:54.549813 systemd[1]: Starting polkit.service - Authorization Manager... Sep 9 23:42:54.571500 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.8870 INFO [amazon-ssm-agent] Starting Core Agent Sep 9 23:42:54.668426 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.8870 INFO [amazon-ssm-agent] Registrar detected. Attempting registration Sep 9 23:42:54.768807 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.8870 INFO [Registrar] Starting registrar module Sep 9 23:42:54.819930 sshd_keygen[1879]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 9 23:42:54.869273 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.8909 INFO [EC2Identity] Checking disk for registration info Sep 9 23:42:54.875565 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 9 23:42:54.883954 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 9 23:42:54.891475 systemd[1]: Started sshd@0-172.31.25.217:22-139.178.89.65:46368.service - OpenSSH per-connection server daemon (139.178.89.65:46368). Sep 9 23:42:54.941536 systemd[1]: issuegen.service: Deactivated successfully. Sep 9 23:42:54.941980 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 9 23:42:54.953885 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 9 23:42:54.973656 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.8910 INFO [EC2Identity] No registration info found for ec2 instance, attempting registration Sep 9 23:42:55.000404 polkitd[2109]: Started polkitd version 126 Sep 9 23:42:55.016931 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 9 23:42:55.029003 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 9 23:42:55.036227 polkitd[2109]: Loading rules from directory /etc/polkit-1/rules.d Sep 9 23:42:55.036878 polkitd[2109]: Loading rules from directory /run/polkit-1/rules.d Sep 9 23:42:55.036954 polkitd[2109]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Sep 9 23:42:55.037590 polkitd[2109]: Loading rules from directory /usr/local/share/polkit-1/rules.d Sep 9 23:42:55.037636 polkitd[2109]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Sep 9 23:42:55.037713 polkitd[2109]: Loading rules from directory /usr/share/polkit-1/rules.d Sep 9 23:42:55.039527 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 9 23:42:55.044432 systemd[1]: Reached target getty.target - Login Prompts. Sep 9 23:42:55.050414 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 9 23:42:55.064506 polkitd[2109]: Finished loading, compiling and executing 2 rules Sep 9 23:42:55.067615 systemd[1]: Started polkit.service - Authorization Manager. Sep 9 23:42:55.072500 amazon-ssm-agent[1952]: 2025-09-09 23:42:53.8910 INFO [EC2Identity] Generating registration keypair Sep 9 23:42:55.074933 systemd[1]: Startup finished in 3.704s (kernel) + 8.809s (initrd) + 8.648s (userspace) = 21.162s. Sep 9 23:42:55.081469 dbus-daemon[1844]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 9 23:42:55.084864 polkitd[2109]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Sep 9 23:42:55.134551 systemd-hostnamed[1910]: Hostname set to (transient) Sep 9 23:42:55.135050 systemd-resolved[1686]: System hostname changed to 'ip-172-31-25-217'. Sep 9 23:42:55.361563 sshd[2127]: Accepted publickey for core from 139.178.89.65 port 46368 ssh2: RSA SHA256:qHlHyIWOCFGyLN0DNo6M0sQy+OrgAlHw4s82lYsZXi8 Sep 9 23:42:55.365116 sshd-session[2127]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:42:55.393500 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 9 23:42:55.398748 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 9 23:42:55.415256 systemd-logind[1874]: New session 1 of user core. Sep 9 23:42:55.443650 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 9 23:42:55.452685 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 9 23:42:55.480597 (systemd)[2151]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 9 23:42:55.485624 systemd-logind[1874]: New session c1 of user core. Sep 9 23:42:55.792082 systemd[2151]: Queued start job for default target default.target. Sep 9 23:42:55.800895 systemd[2151]: Created slice app.slice - User Application Slice. Sep 9 23:42:55.800980 systemd[2151]: Reached target paths.target - Paths. Sep 9 23:42:55.801078 systemd[2151]: Reached target timers.target - Timers. Sep 9 23:42:55.803873 systemd[2151]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 9 23:42:55.837813 systemd[2151]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 9 23:42:55.838087 systemd[2151]: Reached target sockets.target - Sockets. Sep 9 23:42:55.838375 systemd[2151]: Reached target basic.target - Basic System. Sep 9 23:42:55.838541 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 9 23:42:55.839531 systemd[2151]: Reached target default.target - Main User Target. Sep 9 23:42:55.839622 systemd[2151]: Startup finished in 339ms. Sep 9 23:42:55.853923 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 9 23:42:55.925368 amazon-ssm-agent[1952]: 2025-09-09 23:42:55.9251 INFO [EC2Identity] Checking write access before registering Sep 9 23:42:55.934878 ntpd[1863]: Listen normally on 6 eth0 [fe80::451:98ff:fef1:4463%2]:123 Sep 9 23:42:55.935969 ntpd[1863]: 9 Sep 23:42:55 ntpd[1863]: Listen normally on 6 eth0 [fe80::451:98ff:fef1:4463%2]:123 Sep 9 23:42:55.970147 amazon-ssm-agent[1952]: 2025/09/09 23:42:55 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 9 23:42:55.970147 amazon-ssm-agent[1952]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 9 23:42:55.970670 amazon-ssm-agent[1952]: 2025/09/09 23:42:55 processing appconfig overrides Sep 9 23:42:56.010359 amazon-ssm-agent[1952]: 2025-09-09 23:42:55.9267 INFO [EC2Identity] Registering EC2 instance with Systems Manager Sep 9 23:42:56.010359 amazon-ssm-agent[1952]: 2025-09-09 23:42:55.9691 INFO [EC2Identity] EC2 registration was successful. Sep 9 23:42:56.010359 amazon-ssm-agent[1952]: 2025-09-09 23:42:55.9691 INFO [amazon-ssm-agent] Registration attempted. Resuming core agent startup. Sep 9 23:42:56.010943 amazon-ssm-agent[1952]: 2025-09-09 23:42:55.9692 INFO [CredentialRefresher] credentialRefresher has started Sep 9 23:42:56.010943 amazon-ssm-agent[1952]: 2025-09-09 23:42:55.9697 INFO [CredentialRefresher] Starting credentials refresher loop Sep 9 23:42:56.010943 amazon-ssm-agent[1952]: 2025-09-09 23:42:56.0098 INFO EC2RoleProvider Successfully connected with instance profile role credentials Sep 9 23:42:56.010943 amazon-ssm-agent[1952]: 2025-09-09 23:42:56.0101 INFO [CredentialRefresher] Credentials ready Sep 9 23:42:56.011340 systemd[1]: Started sshd@1-172.31.25.217:22-139.178.89.65:46372.service - OpenSSH per-connection server daemon (139.178.89.65:46372). Sep 9 23:42:56.027008 amazon-ssm-agent[1952]: 2025-09-09 23:42:56.0108 INFO [CredentialRefresher] Next credential rotation will be in 29.999984362 minutes Sep 9 23:42:56.232754 sshd[2162]: Accepted publickey for core from 139.178.89.65 port 46372 ssh2: RSA SHA256:qHlHyIWOCFGyLN0DNo6M0sQy+OrgAlHw4s82lYsZXi8 Sep 9 23:42:56.235068 sshd-session[2162]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:42:56.246430 systemd-logind[1874]: New session 2 of user core. Sep 9 23:42:56.253671 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 9 23:42:56.384331 sshd[2165]: Connection closed by 139.178.89.65 port 46372 Sep 9 23:42:56.384555 sshd-session[2162]: pam_unix(sshd:session): session closed for user core Sep 9 23:42:56.391752 systemd-logind[1874]: Session 2 logged out. Waiting for processes to exit. Sep 9 23:42:56.392650 systemd[1]: sshd@1-172.31.25.217:22-139.178.89.65:46372.service: Deactivated successfully. Sep 9 23:42:56.397875 systemd[1]: session-2.scope: Deactivated successfully. Sep 9 23:42:56.402949 systemd-logind[1874]: Removed session 2. Sep 9 23:42:56.423524 systemd[1]: Started sshd@2-172.31.25.217:22-139.178.89.65:46386.service - OpenSSH per-connection server daemon (139.178.89.65:46386). Sep 9 23:42:56.622218 sshd[2171]: Accepted publickey for core from 139.178.89.65 port 46386 ssh2: RSA SHA256:qHlHyIWOCFGyLN0DNo6M0sQy+OrgAlHw4s82lYsZXi8 Sep 9 23:42:56.624960 sshd-session[2171]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:42:56.635428 systemd-logind[1874]: New session 3 of user core. Sep 9 23:42:56.645638 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 9 23:42:56.766704 sshd[2174]: Connection closed by 139.178.89.65 port 46386 Sep 9 23:42:56.767583 sshd-session[2171]: pam_unix(sshd:session): session closed for user core Sep 9 23:42:56.774861 systemd[1]: sshd@2-172.31.25.217:22-139.178.89.65:46386.service: Deactivated successfully. Sep 9 23:42:56.778416 systemd[1]: session-3.scope: Deactivated successfully. Sep 9 23:42:56.781729 systemd-logind[1874]: Session 3 logged out. Waiting for processes to exit. Sep 9 23:42:56.785516 systemd-logind[1874]: Removed session 3. Sep 9 23:42:56.802831 systemd[1]: Started sshd@3-172.31.25.217:22-139.178.89.65:46390.service - OpenSSH per-connection server daemon (139.178.89.65:46390). Sep 9 23:42:57.009173 sshd[2180]: Accepted publickey for core from 139.178.89.65 port 46390 ssh2: RSA SHA256:qHlHyIWOCFGyLN0DNo6M0sQy+OrgAlHw4s82lYsZXi8 Sep 9 23:42:57.012015 sshd-session[2180]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:42:57.025268 systemd-logind[1874]: New session 4 of user core. Sep 9 23:42:57.029604 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 9 23:42:57.048596 amazon-ssm-agent[1952]: 2025-09-09 23:42:57.0481 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Sep 9 23:42:57.149518 amazon-ssm-agent[1952]: 2025-09-09 23:42:57.0519 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2186) started Sep 9 23:42:57.159688 sshd[2185]: Connection closed by 139.178.89.65 port 46390 Sep 9 23:42:57.159942 sshd-session[2180]: pam_unix(sshd:session): session closed for user core Sep 9 23:42:57.170897 systemd[1]: sshd@3-172.31.25.217:22-139.178.89.65:46390.service: Deactivated successfully. Sep 9 23:42:57.177202 systemd[1]: session-4.scope: Deactivated successfully. Sep 9 23:42:57.182821 systemd-logind[1874]: Session 4 logged out. Waiting for processes to exit. Sep 9 23:42:57.204322 systemd[1]: Started sshd@4-172.31.25.217:22-139.178.89.65:46400.service - OpenSSH per-connection server daemon (139.178.89.65:46400). Sep 9 23:42:57.206594 systemd-logind[1874]: Removed session 4. Sep 9 23:42:57.250432 amazon-ssm-agent[1952]: 2025-09-09 23:42:57.0520 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Sep 9 23:42:57.414911 sshd[2197]: Accepted publickey for core from 139.178.89.65 port 46400 ssh2: RSA SHA256:qHlHyIWOCFGyLN0DNo6M0sQy+OrgAlHw4s82lYsZXi8 Sep 9 23:42:57.416964 sshd-session[2197]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:42:57.424828 systemd-logind[1874]: New session 5 of user core. Sep 9 23:42:57.432588 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 9 23:42:57.561857 sudo[2205]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 9 23:42:57.562898 sudo[2205]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:42:57.582131 sudo[2205]: pam_unix(sudo:session): session closed for user root Sep 9 23:42:57.606328 sshd[2204]: Connection closed by 139.178.89.65 port 46400 Sep 9 23:42:57.607369 sshd-session[2197]: pam_unix(sshd:session): session closed for user core Sep 9 23:42:57.615142 systemd[1]: sshd@4-172.31.25.217:22-139.178.89.65:46400.service: Deactivated successfully. Sep 9 23:42:57.619530 systemd[1]: session-5.scope: Deactivated successfully. Sep 9 23:42:57.621900 systemd-logind[1874]: Session 5 logged out. Waiting for processes to exit. Sep 9 23:42:57.624554 systemd-logind[1874]: Removed session 5. Sep 9 23:42:57.642645 systemd[1]: Started sshd@5-172.31.25.217:22-139.178.89.65:46416.service - OpenSSH per-connection server daemon (139.178.89.65:46416). Sep 9 23:42:57.843208 sshd[2211]: Accepted publickey for core from 139.178.89.65 port 46416 ssh2: RSA SHA256:qHlHyIWOCFGyLN0DNo6M0sQy+OrgAlHw4s82lYsZXi8 Sep 9 23:42:57.845684 sshd-session[2211]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:42:57.854343 systemd-logind[1874]: New session 6 of user core. Sep 9 23:42:57.866583 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 9 23:42:57.969342 sudo[2216]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Sep 9 23:42:57.970602 sudo[2216]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:42:57.981213 sudo[2216]: pam_unix(sudo:session): session closed for user root Sep 9 23:42:57.991006 sudo[2215]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 9 23:42:57.992203 sudo[2215]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:42:58.009909 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 9 23:42:58.077960 augenrules[2238]: No rules Sep 9 23:42:58.080429 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 23:42:58.081443 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 9 23:42:58.084819 sudo[2215]: pam_unix(sudo:session): session closed for user root Sep 9 23:42:58.108760 sshd[2214]: Connection closed by 139.178.89.65 port 46416 Sep 9 23:42:58.107873 sshd-session[2211]: pam_unix(sshd:session): session closed for user core Sep 9 23:42:58.114266 systemd-logind[1874]: Session 6 logged out. Waiting for processes to exit. Sep 9 23:42:58.114838 systemd[1]: sshd@5-172.31.25.217:22-139.178.89.65:46416.service: Deactivated successfully. Sep 9 23:42:58.117940 systemd[1]: session-6.scope: Deactivated successfully. Sep 9 23:42:58.122838 systemd-logind[1874]: Removed session 6. Sep 9 23:42:58.147216 systemd[1]: Started sshd@6-172.31.25.217:22-139.178.89.65:46422.service - OpenSSH per-connection server daemon (139.178.89.65:46422). Sep 9 23:42:58.359571 sshd[2247]: Accepted publickey for core from 139.178.89.65 port 46422 ssh2: RSA SHA256:qHlHyIWOCFGyLN0DNo6M0sQy+OrgAlHw4s82lYsZXi8 Sep 9 23:42:58.362241 sshd-session[2247]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:42:58.370975 systemd-logind[1874]: New session 7 of user core. Sep 9 23:42:58.384592 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 9 23:42:58.505875 sshd[2250]: Connection closed by 139.178.89.65 port 46422 Sep 9 23:42:58.506782 sshd-session[2247]: pam_unix(sshd:session): session closed for user core Sep 9 23:42:58.514065 systemd[1]: sshd@6-172.31.25.217:22-139.178.89.65:46422.service: Deactivated successfully. Sep 9 23:42:58.519175 systemd[1]: session-7.scope: Deactivated successfully. Sep 9 23:42:58.521508 systemd-logind[1874]: Session 7 logged out. Waiting for processes to exit. Sep 9 23:42:58.525009 systemd-logind[1874]: Removed session 7.