Oct 28 04:40:20.557841 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Oct 28 04:40:20.557889 kernel: Linux version 6.12.54-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.1_p20250801 p4) 14.3.1 20250801, GNU ld (Gentoo 2.45 p3) 2.45.0) #1 SMP PREEMPT Tue Oct 28 03:20:07 -00 2025 Oct 28 04:40:20.557914 kernel: KASLR disabled due to lack of seed Oct 28 04:40:20.557931 kernel: efi: EFI v2.7 by EDK II Oct 28 04:40:20.557948 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7a731a98 MEMRESERVE=0x78557598 Oct 28 04:40:20.557964 kernel: secureboot: Secure boot disabled Oct 28 04:40:20.557982 kernel: ACPI: Early table checksum verification disabled Oct 28 04:40:20.557998 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Oct 28 04:40:20.558014 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Oct 28 04:40:20.558034 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Oct 28 04:40:20.558050 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Oct 28 04:40:20.558065 kernel: ACPI: FACS 0x0000000078630000 000040 Oct 28 04:40:20.558081 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Oct 28 04:40:20.558097 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Oct 28 04:40:20.558150 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Oct 28 04:40:20.558170 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Oct 28 04:40:20.558188 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Oct 28 04:40:20.558205 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Oct 28 04:40:20.558222 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Oct 28 04:40:20.558238 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Oct 28 04:40:20.558255 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Oct 28 04:40:20.558301 kernel: printk: legacy bootconsole [uart0] enabled Oct 28 04:40:20.558321 kernel: ACPI: Use ACPI SPCR as default console: No Oct 28 04:40:20.558340 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Oct 28 04:40:20.558364 kernel: NODE_DATA(0) allocated [mem 0x4b584da00-0x4b5854fff] Oct 28 04:40:20.558382 kernel: Zone ranges: Oct 28 04:40:20.558399 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Oct 28 04:40:20.558416 kernel: DMA32 empty Oct 28 04:40:20.558433 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Oct 28 04:40:20.558450 kernel: Device empty Oct 28 04:40:20.558466 kernel: Movable zone start for each node Oct 28 04:40:20.558483 kernel: Early memory node ranges Oct 28 04:40:20.558500 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Oct 28 04:40:20.558516 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Oct 28 04:40:20.558533 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Oct 28 04:40:20.558549 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Oct 28 04:40:20.558570 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Oct 28 04:40:20.558587 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Oct 28 04:40:20.558603 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Oct 28 04:40:20.558620 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Oct 28 04:40:20.558644 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Oct 28 04:40:20.558665 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Oct 28 04:40:20.558684 kernel: cma: Reserved 16 MiB at 0x000000007f000000 on node -1 Oct 28 04:40:20.558701 kernel: psci: probing for conduit method from ACPI. Oct 28 04:40:20.558719 kernel: psci: PSCIv1.0 detected in firmware. Oct 28 04:40:20.558737 kernel: psci: Using standard PSCI v0.2 function IDs Oct 28 04:40:20.558755 kernel: psci: Trusted OS migration not required Oct 28 04:40:20.558772 kernel: psci: SMC Calling Convention v1.1 Oct 28 04:40:20.558790 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Oct 28 04:40:20.558807 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Oct 28 04:40:20.558829 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Oct 28 04:40:20.558847 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 28 04:40:20.558864 kernel: Detected PIPT I-cache on CPU0 Oct 28 04:40:20.558882 kernel: CPU features: detected: GIC system register CPU interface Oct 28 04:40:20.558925 kernel: CPU features: detected: Spectre-v2 Oct 28 04:40:20.558946 kernel: CPU features: detected: Spectre-v3a Oct 28 04:40:20.558964 kernel: CPU features: detected: Spectre-BHB Oct 28 04:40:20.558982 kernel: CPU features: detected: ARM erratum 1742098 Oct 28 04:40:20.559000 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Oct 28 04:40:20.559017 kernel: alternatives: applying boot alternatives Oct 28 04:40:20.559037 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=1f35b74acbf2082d1ccaf19af5ba856ed6811e7fe1caa7e6e44e2aaa205180aa Oct 28 04:40:20.559062 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 28 04:40:20.559080 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 28 04:40:20.559097 kernel: Fallback order for Node 0: 0 Oct 28 04:40:20.559145 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1007616 Oct 28 04:40:20.559165 kernel: Policy zone: Normal Oct 28 04:40:20.559183 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 28 04:40:20.559201 kernel: software IO TLB: area num 2. Oct 28 04:40:20.559218 kernel: software IO TLB: mapped [mem 0x000000006f800000-0x0000000073800000] (64MB) Oct 28 04:40:20.559236 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 28 04:40:20.559253 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 28 04:40:20.559278 kernel: rcu: RCU event tracing is enabled. Oct 28 04:40:20.559296 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 28 04:40:20.559314 kernel: Trampoline variant of Tasks RCU enabled. Oct 28 04:40:20.559332 kernel: Tracing variant of Tasks RCU enabled. Oct 28 04:40:20.559350 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 28 04:40:20.559368 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 28 04:40:20.559387 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 28 04:40:20.559405 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 28 04:40:20.559423 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 28 04:40:20.559441 kernel: GICv3: 96 SPIs implemented Oct 28 04:40:20.559458 kernel: GICv3: 0 Extended SPIs implemented Oct 28 04:40:20.559481 kernel: Root IRQ handler: gic_handle_irq Oct 28 04:40:20.559498 kernel: GICv3: GICv3 features: 16 PPIs Oct 28 04:40:20.559516 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Oct 28 04:40:20.559533 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Oct 28 04:40:20.559551 kernel: ITS [mem 0x10080000-0x1009ffff] Oct 28 04:40:20.559569 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000f0000 (indirect, esz 8, psz 64K, shr 1) Oct 28 04:40:20.559587 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @400100000 (flat, esz 8, psz 64K, shr 1) Oct 28 04:40:20.559605 kernel: GICv3: using LPI property table @0x0000000400110000 Oct 28 04:40:20.559622 kernel: ITS: Using hypervisor restricted LPI range [128] Oct 28 04:40:20.559640 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000400120000 Oct 28 04:40:20.559658 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 28 04:40:20.559681 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Oct 28 04:40:20.559699 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Oct 28 04:40:20.559717 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Oct 28 04:40:20.559735 kernel: Console: colour dummy device 80x25 Oct 28 04:40:20.559755 kernel: printk: legacy console [tty1] enabled Oct 28 04:40:20.559774 kernel: ACPI: Core revision 20240827 Oct 28 04:40:20.559793 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Oct 28 04:40:20.559812 kernel: pid_max: default: 32768 minimum: 301 Oct 28 04:40:20.559836 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 28 04:40:20.559855 kernel: landlock: Up and running. Oct 28 04:40:20.559873 kernel: SELinux: Initializing. Oct 28 04:40:20.559892 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:40:20.559911 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:40:20.559930 kernel: rcu: Hierarchical SRCU implementation. Oct 28 04:40:20.559949 kernel: rcu: Max phase no-delay instances is 400. Oct 28 04:40:20.559967 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 28 04:40:20.559991 kernel: Remapping and enabling EFI services. Oct 28 04:40:20.560009 kernel: smp: Bringing up secondary CPUs ... Oct 28 04:40:20.560028 kernel: Detected PIPT I-cache on CPU1 Oct 28 04:40:20.560046 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Oct 28 04:40:20.560089 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000400130000 Oct 28 04:40:20.560139 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Oct 28 04:40:20.560161 kernel: smp: Brought up 1 node, 2 CPUs Oct 28 04:40:20.560188 kernel: SMP: Total of 2 processors activated. Oct 28 04:40:20.560207 kernel: CPU: All CPU(s) started at EL1 Oct 28 04:40:20.560237 kernel: CPU features: detected: 32-bit EL0 Support Oct 28 04:40:20.560259 kernel: CPU features: detected: 32-bit EL1 Support Oct 28 04:40:20.560278 kernel: CPU features: detected: CRC32 instructions Oct 28 04:40:20.560297 kernel: alternatives: applying system-wide alternatives Oct 28 04:40:20.560317 kernel: Memory: 3822956K/4030464K available (11136K kernel code, 2456K rwdata, 9084K rodata, 12992K init, 1038K bss, 186164K reserved, 16384K cma-reserved) Oct 28 04:40:20.560337 kernel: devtmpfs: initialized Oct 28 04:40:20.560360 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 28 04:40:20.560379 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 28 04:40:20.560398 kernel: 23536 pages in range for non-PLT usage Oct 28 04:40:20.560417 kernel: 515056 pages in range for PLT usage Oct 28 04:40:20.560436 kernel: pinctrl core: initialized pinctrl subsystem Oct 28 04:40:20.560458 kernel: SMBIOS 3.0.0 present. Oct 28 04:40:20.560477 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Oct 28 04:40:20.560496 kernel: DMI: Memory slots populated: 0/0 Oct 28 04:40:20.560515 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 28 04:40:20.560534 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 28 04:40:20.560553 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 28 04:40:20.560573 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 28 04:40:20.560596 kernel: audit: initializing netlink subsys (disabled) Oct 28 04:40:20.560616 kernel: audit: type=2000 audit(0.228:1): state=initialized audit_enabled=0 res=1 Oct 28 04:40:20.560634 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 28 04:40:20.560654 kernel: cpuidle: using governor menu Oct 28 04:40:20.560673 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 28 04:40:20.560693 kernel: ASID allocator initialised with 65536 entries Oct 28 04:40:20.560712 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 28 04:40:20.560735 kernel: Serial: AMBA PL011 UART driver Oct 28 04:40:20.560754 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 28 04:40:20.560773 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 28 04:40:20.560792 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 28 04:40:20.560811 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 28 04:40:20.560830 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 28 04:40:20.560849 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 28 04:40:20.560874 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 28 04:40:20.560894 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 28 04:40:20.560913 kernel: ACPI: Added _OSI(Module Device) Oct 28 04:40:20.560934 kernel: ACPI: Added _OSI(Processor Device) Oct 28 04:40:20.560954 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 28 04:40:20.560974 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 28 04:40:20.560994 kernel: ACPI: Interpreter enabled Oct 28 04:40:20.561020 kernel: ACPI: Using GIC for interrupt routing Oct 28 04:40:20.561039 kernel: ACPI: MCFG table detected, 1 entries Oct 28 04:40:20.561059 kernel: ACPI: CPU0 has been hot-added Oct 28 04:40:20.561078 kernel: ACPI: CPU1 has been hot-added Oct 28 04:40:20.561097 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Oct 28 04:40:20.561519 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 28 04:40:20.561798 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 28 04:40:20.562089 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 28 04:40:20.562439 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Oct 28 04:40:20.562711 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Oct 28 04:40:20.562741 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Oct 28 04:40:20.562761 kernel: acpiphp: Slot [1] registered Oct 28 04:40:20.562780 kernel: acpiphp: Slot [2] registered Oct 28 04:40:20.562810 kernel: acpiphp: Slot [3] registered Oct 28 04:40:20.562829 kernel: acpiphp: Slot [4] registered Oct 28 04:40:20.562848 kernel: acpiphp: Slot [5] registered Oct 28 04:40:20.562866 kernel: acpiphp: Slot [6] registered Oct 28 04:40:20.562885 kernel: acpiphp: Slot [7] registered Oct 28 04:40:20.562904 kernel: acpiphp: Slot [8] registered Oct 28 04:40:20.562923 kernel: acpiphp: Slot [9] registered Oct 28 04:40:20.562942 kernel: acpiphp: Slot [10] registered Oct 28 04:40:20.562965 kernel: acpiphp: Slot [11] registered Oct 28 04:40:20.562985 kernel: acpiphp: Slot [12] registered Oct 28 04:40:20.563004 kernel: acpiphp: Slot [13] registered Oct 28 04:40:20.563023 kernel: acpiphp: Slot [14] registered Oct 28 04:40:20.563042 kernel: acpiphp: Slot [15] registered Oct 28 04:40:20.563061 kernel: acpiphp: Slot [16] registered Oct 28 04:40:20.563080 kernel: acpiphp: Slot [17] registered Oct 28 04:40:20.563127 kernel: acpiphp: Slot [18] registered Oct 28 04:40:20.563154 kernel: acpiphp: Slot [19] registered Oct 28 04:40:20.563174 kernel: acpiphp: Slot [20] registered Oct 28 04:40:20.563193 kernel: acpiphp: Slot [21] registered Oct 28 04:40:20.563212 kernel: acpiphp: Slot [22] registered Oct 28 04:40:20.563231 kernel: acpiphp: Slot [23] registered Oct 28 04:40:20.563249 kernel: acpiphp: Slot [24] registered Oct 28 04:40:20.563275 kernel: acpiphp: Slot [25] registered Oct 28 04:40:20.563294 kernel: acpiphp: Slot [26] registered Oct 28 04:40:20.563313 kernel: acpiphp: Slot [27] registered Oct 28 04:40:20.563332 kernel: acpiphp: Slot [28] registered Oct 28 04:40:20.563350 kernel: acpiphp: Slot [29] registered Oct 28 04:40:20.563369 kernel: acpiphp: Slot [30] registered Oct 28 04:40:20.563388 kernel: acpiphp: Slot [31] registered Oct 28 04:40:20.563407 kernel: PCI host bridge to bus 0000:00 Oct 28 04:40:20.563708 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Oct 28 04:40:20.563951 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 28 04:40:20.564258 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Oct 28 04:40:20.564505 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Oct 28 04:40:20.564826 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 conventional PCI endpoint Oct 28 04:40:20.565177 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 conventional PCI endpoint Oct 28 04:40:20.565475 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff] Oct 28 04:40:20.565778 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 PCIe Root Complex Integrated Endpoint Oct 28 04:40:20.566091 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80114000-0x80117fff] Oct 28 04:40:20.566447 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 28 04:40:20.566747 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 PCIe Root Complex Integrated Endpoint Oct 28 04:40:20.567014 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80110000-0x80113fff] Oct 28 04:40:20.567318 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref] Oct 28 04:40:20.567597 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff] Oct 28 04:40:20.567880 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 28 04:40:20.568211 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref]: assigned Oct 28 04:40:20.568506 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff]: assigned Oct 28 04:40:20.568785 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80110000-0x80113fff]: assigned Oct 28 04:40:20.569045 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80114000-0x80117fff]: assigned Oct 28 04:40:20.569387 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff]: assigned Oct 28 04:40:20.569709 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Oct 28 04:40:20.569960 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 28 04:40:20.570272 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Oct 28 04:40:20.570304 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 28 04:40:20.570326 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 28 04:40:20.570346 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 28 04:40:20.570365 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 28 04:40:20.570384 kernel: iommu: Default domain type: Translated Oct 28 04:40:20.570403 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 28 04:40:20.570432 kernel: efivars: Registered efivars operations Oct 28 04:40:20.570451 kernel: vgaarb: loaded Oct 28 04:40:20.570469 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 28 04:40:20.570489 kernel: VFS: Disk quotas dquot_6.6.0 Oct 28 04:40:20.570508 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 28 04:40:20.570527 kernel: pnp: PnP ACPI init Oct 28 04:40:20.570818 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Oct 28 04:40:20.570856 kernel: pnp: PnP ACPI: found 1 devices Oct 28 04:40:20.570876 kernel: NET: Registered PF_INET protocol family Oct 28 04:40:20.570896 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 28 04:40:20.570915 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 28 04:40:20.570934 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 28 04:40:20.570953 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 28 04:40:20.570973 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 28 04:40:20.570996 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 28 04:40:20.571015 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:40:20.571035 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:40:20.571053 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 28 04:40:20.571072 kernel: PCI: CLS 0 bytes, default 64 Oct 28 04:40:20.571092 kernel: kvm [1]: HYP mode not available Oct 28 04:40:20.571141 kernel: Initialise system trusted keyrings Oct 28 04:40:20.571169 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 28 04:40:20.571189 kernel: Key type asymmetric registered Oct 28 04:40:20.571208 kernel: Asymmetric key parser 'x509' registered Oct 28 04:40:20.571228 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 28 04:40:20.571248 kernel: io scheduler mq-deadline registered Oct 28 04:40:20.571267 kernel: io scheduler kyber registered Oct 28 04:40:20.571286 kernel: io scheduler bfq registered Oct 28 04:40:20.571597 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Oct 28 04:40:20.571626 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 28 04:40:20.571645 kernel: ACPI: button: Power Button [PWRB] Oct 28 04:40:20.571665 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Oct 28 04:40:20.571685 kernel: ACPI: button: Sleep Button [SLPB] Oct 28 04:40:20.571705 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 28 04:40:20.571730 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Oct 28 04:40:20.571986 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Oct 28 04:40:20.572012 kernel: printk: legacy console [ttyS0] disabled Oct 28 04:40:20.572032 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Oct 28 04:40:20.572051 kernel: printk: legacy console [ttyS0] enabled Oct 28 04:40:20.572091 kernel: printk: legacy bootconsole [uart0] disabled Oct 28 04:40:20.572134 kernel: thunder_xcv, ver 1.0 Oct 28 04:40:20.572162 kernel: thunder_bgx, ver 1.0 Oct 28 04:40:20.572182 kernel: nicpf, ver 1.0 Oct 28 04:40:20.572200 kernel: nicvf, ver 1.0 Oct 28 04:40:20.572488 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 28 04:40:20.572737 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-28T04:40:18 UTC (1761626418) Oct 28 04:40:20.572764 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 28 04:40:20.572783 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 (0,80000003) counters available Oct 28 04:40:20.572809 kernel: NET: Registered PF_INET6 protocol family Oct 28 04:40:20.572828 kernel: watchdog: NMI not fully supported Oct 28 04:40:20.572847 kernel: watchdog: Hard watchdog permanently disabled Oct 28 04:40:20.572866 kernel: Segment Routing with IPv6 Oct 28 04:40:20.572884 kernel: In-situ OAM (IOAM) with IPv6 Oct 28 04:40:20.572903 kernel: NET: Registered PF_PACKET protocol family Oct 28 04:40:20.572922 kernel: Key type dns_resolver registered Oct 28 04:40:20.572944 kernel: registered taskstats version 1 Oct 28 04:40:20.572963 kernel: Loading compiled-in X.509 certificates Oct 28 04:40:20.572982 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.54-flatcar: 26b98883ef58589f904405bf68dab5f3eec1fa06' Oct 28 04:40:20.573001 kernel: Demotion targets for Node 0: null Oct 28 04:40:20.573020 kernel: Key type .fscrypt registered Oct 28 04:40:20.573038 kernel: Key type fscrypt-provisioning registered Oct 28 04:40:20.573057 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 28 04:40:20.573080 kernel: ima: Allocated hash algorithm: sha1 Oct 28 04:40:20.573099 kernel: ima: No architecture policies found Oct 28 04:40:20.573147 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 28 04:40:20.573167 kernel: clk: Disabling unused clocks Oct 28 04:40:20.573186 kernel: PM: genpd: Disabling unused power domains Oct 28 04:40:20.573205 kernel: Freeing unused kernel memory: 12992K Oct 28 04:40:20.573223 kernel: Run /init as init process Oct 28 04:40:20.573248 kernel: with arguments: Oct 28 04:40:20.573266 kernel: /init Oct 28 04:40:20.573285 kernel: with environment: Oct 28 04:40:20.573303 kernel: HOME=/ Oct 28 04:40:20.573322 kernel: TERM=linux Oct 28 04:40:20.573341 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Oct 28 04:40:20.573574 kernel: nvme nvme0: pci function 0000:00:04.0 Oct 28 04:40:20.573796 kernel: nvme nvme0: 2/0/0 default/read/poll queues Oct 28 04:40:20.573827 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 28 04:40:20.573846 kernel: GPT:25804799 != 33554431 Oct 28 04:40:20.573865 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 28 04:40:20.573884 kernel: GPT:25804799 != 33554431 Oct 28 04:40:20.573902 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 28 04:40:20.573921 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 28 04:40:20.573948 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.573968 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.573987 kernel: SCSI subsystem initialized Oct 28 04:40:20.574006 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.574025 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 28 04:40:20.574044 kernel: device-mapper: uevent: version 1.0.3 Oct 28 04:40:20.574064 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 28 04:40:20.574087 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 28 04:40:20.574141 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.574165 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.574184 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.574204 kernel: raid6: neonx8 gen() 6606 MB/s Oct 28 04:40:20.574223 kernel: raid6: neonx4 gen() 6587 MB/s Oct 28 04:40:20.574242 kernel: raid6: neonx2 gen() 5475 MB/s Oct 28 04:40:20.574268 kernel: raid6: neonx1 gen() 3968 MB/s Oct 28 04:40:20.574287 kernel: raid6: int64x8 gen() 3660 MB/s Oct 28 04:40:20.574306 kernel: raid6: int64x4 gen() 3713 MB/s Oct 28 04:40:20.574325 kernel: raid6: int64x2 gen() 3616 MB/s Oct 28 04:40:20.574344 kernel: raid6: int64x1 gen() 2764 MB/s Oct 28 04:40:20.574363 kernel: raid6: using algorithm neonx8 gen() 6606 MB/s Oct 28 04:40:20.574382 kernel: raid6: .... xor() 4727 MB/s, rmw enabled Oct 28 04:40:20.574400 kernel: raid6: using neon recovery algorithm Oct 28 04:40:20.574424 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.574442 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.574461 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.574480 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.574498 kernel: xor: measuring software checksum speed Oct 28 04:40:20.574517 kernel: 8regs : 12992 MB/sec Oct 28 04:40:20.574537 kernel: 32regs : 11762 MB/sec Oct 28 04:40:20.574555 kernel: arm64_neon : 9174 MB/sec Oct 28 04:40:20.574578 kernel: xor: using function: 8regs (12992 MB/sec) Oct 28 04:40:20.574597 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.574616 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 28 04:40:20.574635 kernel: BTRFS: device fsid caa7e5e1-1ce1-458b-ad52-fda248cb60f9 devid 1 transid 36 /dev/mapper/usr (254:0) scanned by mount (220) Oct 28 04:40:20.574655 kernel: BTRFS info (device dm-0): first mount of filesystem caa7e5e1-1ce1-458b-ad52-fda248cb60f9 Oct 28 04:40:20.574675 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 28 04:40:20.574695 kernel: BTRFS info (device dm-0): enabling ssd optimizations Oct 28 04:40:20.574719 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 28 04:40:20.574738 kernel: BTRFS info (device dm-0): enabling free space tree Oct 28 04:40:20.574758 kernel: Invalid ELF header magic: != \u007fELF Oct 28 04:40:20.574796 kernel: loop: module loaded Oct 28 04:40:20.574820 kernel: loop0: detected capacity change from 0 to 91480 Oct 28 04:40:20.574840 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 28 04:40:20.574862 systemd[1]: Successfully made /usr/ read-only. Oct 28 04:40:20.574893 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +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 -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Oct 28 04:40:20.574916 systemd[1]: Detected virtualization amazon. Oct 28 04:40:20.574937 systemd[1]: Detected architecture arm64. Oct 28 04:40:20.574957 systemd[1]: Running in initrd. Oct 28 04:40:20.574978 systemd[1]: No hostname configured, using default hostname. Oct 28 04:40:20.575004 systemd[1]: Hostname set to . Oct 28 04:40:20.575029 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 28 04:40:20.575050 systemd[1]: Queued start job for default target initrd.target. Oct 28 04:40:20.575071 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Oct 28 04:40:20.575092 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 28 04:40:20.575142 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 28 04:40:20.575167 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 28 04:40:20.575196 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 28 04:40:20.575219 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 28 04:40:20.575241 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 28 04:40:20.575263 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 28 04:40:20.575285 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 28 04:40:20.575308 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 28 04:40:20.575333 systemd[1]: Reached target paths.target - Path Units. Oct 28 04:40:20.575355 systemd[1]: Reached target slices.target - Slice Units. Oct 28 04:40:20.575376 systemd[1]: Reached target swap.target - Swaps. Oct 28 04:40:20.575398 systemd[1]: Reached target timers.target - Timer Units. Oct 28 04:40:20.575420 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 28 04:40:20.575441 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 28 04:40:20.575463 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 28 04:40:20.575489 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 28 04:40:20.575510 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 28 04:40:20.575532 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 28 04:40:20.575554 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 28 04:40:20.575575 systemd[1]: Reached target sockets.target - Socket Units. Oct 28 04:40:20.575597 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 28 04:40:20.575624 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 28 04:40:20.575647 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 28 04:40:20.575669 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 28 04:40:20.575693 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). Oct 28 04:40:20.575716 systemd[1]: Starting systemd-fsck-usr.service... Oct 28 04:40:20.575746 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 28 04:40:20.575769 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 28 04:40:20.575791 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 28 04:40:20.575815 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 28 04:40:20.575844 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 28 04:40:20.575866 systemd[1]: Finished systemd-fsck-usr.service. Oct 28 04:40:20.575890 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 28 04:40:20.575912 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 28 04:40:20.575934 kernel: Bridge firewalling registered Oct 28 04:40:20.575956 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 28 04:40:20.576076 systemd-journald[357]: Collecting audit messages is disabled. Oct 28 04:40:20.576158 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 28 04:40:20.576182 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 28 04:40:20.576214 systemd-journald[357]: Journal started Oct 28 04:40:20.576253 systemd-journald[357]: Runtime Journal (/run/log/journal/ec2a7bdbd50d68ca448722c407507c8c) is 8M, max 75.3M, 67.3M free. Oct 28 04:40:20.538254 systemd-modules-load[358]: Inserted module 'br_netfilter' Oct 28 04:40:20.588153 systemd[1]: Started systemd-journald.service - Journal Service. Oct 28 04:40:20.595421 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 28 04:40:20.604915 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 28 04:40:20.614389 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 28 04:40:20.627191 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 28 04:40:20.666306 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 28 04:40:20.674717 systemd-tmpfiles[379]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 28 04:40:20.688404 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 28 04:40:20.696370 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 28 04:40:20.709316 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 28 04:40:20.715644 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 28 04:40:20.727366 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 28 04:40:20.779573 dracut-cmdline[398]: 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=1f35b74acbf2082d1ccaf19af5ba856ed6811e7fe1caa7e6e44e2aaa205180aa Oct 28 04:40:20.842822 systemd-resolved[392]: Positive Trust Anchors: Oct 28 04:40:20.842861 systemd-resolved[392]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 04:40:20.842870 systemd-resolved[392]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 28 04:40:20.842931 systemd-resolved[392]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 28 04:40:21.013168 kernel: Loading iSCSI transport class v2.0-870. Oct 28 04:40:21.028147 kernel: iscsi: registered transport (tcp) Oct 28 04:40:21.052143 kernel: iscsi: registered transport (qla4xxx) Oct 28 04:40:21.052218 kernel: QLogic iSCSI HBA Driver Oct 28 04:40:21.092268 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 28 04:40:21.134340 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 28 04:40:21.144769 systemd-resolved[392]: Defaulting to hostname 'linux'. Oct 28 04:40:21.147899 kernel: random: crng init done Oct 28 04:40:21.149545 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 28 04:40:21.156645 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 28 04:40:21.162851 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 28 04:40:21.239186 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 28 04:40:21.245394 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 28 04:40:21.249800 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 28 04:40:21.314958 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 28 04:40:21.322976 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 28 04:40:21.382337 systemd-udevd[637]: Using default interface naming scheme 'v257'. Oct 28 04:40:21.403478 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 28 04:40:21.413270 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 28 04:40:21.465210 dracut-pre-trigger[703]: rd.md=0: removing MD RAID activation Oct 28 04:40:21.475206 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 28 04:40:21.485540 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 28 04:40:21.541213 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 28 04:40:21.547312 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 28 04:40:21.595793 systemd-networkd[751]: lo: Link UP Oct 28 04:40:21.595812 systemd-networkd[751]: lo: Gained carrier Oct 28 04:40:21.599258 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 28 04:40:21.601766 systemd[1]: Reached target network.target - Network. Oct 28 04:40:21.705215 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 28 04:40:21.719077 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 28 04:40:21.878178 kernel: nvme nvme0: using unchecked data buffer Oct 28 04:40:21.939643 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 28 04:40:21.939709 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Oct 28 04:40:21.965230 kernel: ena 0000:00:05.0: ENA device version: 0.10 Oct 28 04:40:21.965660 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Oct 28 04:40:21.968306 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 04:40:21.970678 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 28 04:40:21.975880 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 28 04:40:21.982529 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 28 04:40:22.007146 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:d0:44:56:e3:75 Oct 28 04:40:22.016851 (udev-worker)[805]: Network interface NamePolicy= disabled on kernel command line. Oct 28 04:40:22.048880 systemd-networkd[751]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 28 04:40:22.048894 systemd-networkd[751]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 28 04:40:22.067281 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 28 04:40:22.076538 systemd-networkd[751]: eth0: Link UP Oct 28 04:40:22.076831 systemd-networkd[751]: eth0: Gained carrier Oct 28 04:40:22.076853 systemd-networkd[751]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 28 04:40:22.097229 systemd-networkd[751]: eth0: DHCPv4 address 172.31.24.152/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 28 04:40:22.172266 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Oct 28 04:40:22.208518 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Oct 28 04:40:22.233520 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Oct 28 04:40:22.237392 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 28 04:40:22.266861 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Oct 28 04:40:22.301978 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 28 04:40:22.308595 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 28 04:40:22.311413 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 28 04:40:22.320355 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 28 04:40:22.326672 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 28 04:40:22.347139 disk-uuid[911]: Primary Header is updated. Oct 28 04:40:22.347139 disk-uuid[911]: Secondary Entries is updated. Oct 28 04:40:22.347139 disk-uuid[911]: Secondary Header is updated. Oct 28 04:40:22.380364 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 28 04:40:23.417783 disk-uuid[912]: Warning: The kernel is still using the old partition table. Oct 28 04:40:23.417783 disk-uuid[912]: The new table will be used at the next reboot or after you Oct 28 04:40:23.417783 disk-uuid[912]: run partprobe(8) or kpartx(8) Oct 28 04:40:23.417783 disk-uuid[912]: The operation has completed successfully. Oct 28 04:40:23.439960 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 28 04:40:23.440295 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 28 04:40:23.443374 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 28 04:40:23.502151 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1095) Oct 28 04:40:23.507443 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 52a6d1c0-1d9b-4b64-8a3d-40978d54767d Oct 28 04:40:23.507519 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Oct 28 04:40:23.546229 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 28 04:40:23.546338 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 28 04:40:23.557172 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 52a6d1c0-1d9b-4b64-8a3d-40978d54767d Oct 28 04:40:23.559300 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 28 04:40:23.565394 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 28 04:40:23.589303 systemd-networkd[751]: eth0: Gained IPv6LL Oct 28 04:40:23.813100 ignition[1114]: Ignition 2.22.0 Oct 28 04:40:23.814977 ignition[1114]: Stage: fetch-offline Oct 28 04:40:23.816001 ignition[1114]: no configs at "/usr/lib/ignition/base.d" Oct 28 04:40:23.816029 ignition[1114]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 28 04:40:23.820453 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 28 04:40:23.816763 ignition[1114]: Ignition finished successfully Oct 28 04:40:23.830592 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 28 04:40:23.885622 ignition[1123]: Ignition 2.22.0 Oct 28 04:40:23.885655 ignition[1123]: Stage: fetch Oct 28 04:40:23.887344 ignition[1123]: no configs at "/usr/lib/ignition/base.d" Oct 28 04:40:23.887373 ignition[1123]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 28 04:40:23.887531 ignition[1123]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 28 04:40:23.905286 ignition[1123]: PUT result: OK Oct 28 04:40:23.908936 ignition[1123]: parsed url from cmdline: "" Oct 28 04:40:23.908953 ignition[1123]: no config URL provided Oct 28 04:40:23.908969 ignition[1123]: reading system config file "/usr/lib/ignition/user.ign" Oct 28 04:40:23.909705 ignition[1123]: no config at "/usr/lib/ignition/user.ign" Oct 28 04:40:23.911538 ignition[1123]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 28 04:40:23.917656 ignition[1123]: PUT result: OK Oct 28 04:40:23.917789 ignition[1123]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Oct 28 04:40:23.920380 ignition[1123]: GET result: OK Oct 28 04:40:23.920489 ignition[1123]: parsing config with SHA512: 341e0e8d0476ea742a94191934d545930598207b0a8c08ddd4d27dcee9262de4c660dc00dbcab3a4915f4844def8a3706afd5f89aefc92c25dbf01cd4ab2e2f1 Oct 28 04:40:23.934076 unknown[1123]: fetched base config from "system" Oct 28 04:40:23.934099 unknown[1123]: fetched base config from "system" Oct 28 04:40:23.936126 ignition[1123]: fetch: fetch complete Oct 28 04:40:23.934164 unknown[1123]: fetched user config from "aws" Oct 28 04:40:23.936166 ignition[1123]: fetch: fetch passed Oct 28 04:40:23.936278 ignition[1123]: Ignition finished successfully Oct 28 04:40:23.949061 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 28 04:40:23.955560 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 28 04:40:24.011090 ignition[1130]: Ignition 2.22.0 Oct 28 04:40:24.011635 ignition[1130]: Stage: kargs Oct 28 04:40:24.013052 ignition[1130]: no configs at "/usr/lib/ignition/base.d" Oct 28 04:40:24.013075 ignition[1130]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 28 04:40:24.013515 ignition[1130]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 28 04:40:24.023073 ignition[1130]: PUT result: OK Oct 28 04:40:24.029431 ignition[1130]: kargs: kargs passed Oct 28 04:40:24.029585 ignition[1130]: Ignition finished successfully Oct 28 04:40:24.035158 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 28 04:40:24.042984 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 28 04:40:24.104841 ignition[1136]: Ignition 2.22.0 Oct 28 04:40:24.105372 ignition[1136]: Stage: disks Oct 28 04:40:24.105920 ignition[1136]: no configs at "/usr/lib/ignition/base.d" Oct 28 04:40:24.105941 ignition[1136]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 28 04:40:24.106135 ignition[1136]: PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 28 04:40:24.110167 ignition[1136]: PUT result: OK Oct 28 04:40:24.118260 ignition[1136]: disks: disks passed Oct 28 04:40:24.118362 ignition[1136]: Ignition finished successfully Oct 28 04:40:24.125260 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 28 04:40:24.127907 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 28 04:40:24.130390 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 28 04:40:24.133072 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 28 04:40:24.137223 systemd[1]: Reached target sysinit.target - System Initialization. Oct 28 04:40:24.141735 systemd[1]: Reached target basic.target - Basic System. Oct 28 04:40:24.145279 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 28 04:40:24.270013 systemd-fsck[1145]: ROOT: clean, 15/1631200 files, 112378/1617920 blocks Oct 28 04:40:24.274733 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 28 04:40:24.281304 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 28 04:40:24.431147 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 8fca153a-dda8-4620-af0a-8ec5cf72e73c r/w with ordered data mode. Quota mode: none. Oct 28 04:40:24.432721 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 28 04:40:24.438753 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 28 04:40:24.492979 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 28 04:40:24.499680 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 28 04:40:24.507702 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 28 04:40:24.507791 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 28 04:40:24.507841 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 28 04:40:24.530051 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 28 04:40:24.534799 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 28 04:40:24.547137 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1164) Oct 28 04:40:24.552272 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 52a6d1c0-1d9b-4b64-8a3d-40978d54767d Oct 28 04:40:24.552346 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Oct 28 04:40:24.560796 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 28 04:40:24.560888 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 28 04:40:24.564486 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 28 04:40:24.667870 initrd-setup-root[1189]: cut: /sysroot/etc/passwd: No such file or directory Oct 28 04:40:24.677243 initrd-setup-root[1196]: cut: /sysroot/etc/group: No such file or directory Oct 28 04:40:24.687202 initrd-setup-root[1203]: cut: /sysroot/etc/shadow: No such file or directory Oct 28 04:40:24.696303 initrd-setup-root[1210]: cut: /sysroot/etc/gshadow: No such file or directory Oct 28 04:40:24.873791 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 28 04:40:24.879982 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 28 04:40:24.890083 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 28 04:40:24.908915 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 28 04:40:24.913245 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 52a6d1c0-1d9b-4b64-8a3d-40978d54767d Oct 28 04:40:24.965183 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 28 04:40:24.967485 ignition[1277]: INFO : Ignition 2.22.0 Oct 28 04:40:24.971630 ignition[1277]: INFO : Stage: mount Oct 28 04:40:24.971630 ignition[1277]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 28 04:40:24.971630 ignition[1277]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 28 04:40:24.971630 ignition[1277]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 28 04:40:24.971630 ignition[1277]: INFO : PUT result: OK Oct 28 04:40:24.984234 ignition[1277]: INFO : mount: mount passed Oct 28 04:40:24.984234 ignition[1277]: INFO : Ignition finished successfully Oct 28 04:40:24.986460 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 28 04:40:24.991250 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 28 04:40:25.022240 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 28 04:40:25.054138 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1290) Oct 28 04:40:25.058814 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 52a6d1c0-1d9b-4b64-8a3d-40978d54767d Oct 28 04:40:25.058866 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Oct 28 04:40:25.066317 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 28 04:40:25.066392 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 28 04:40:25.070397 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 28 04:40:25.131953 ignition[1307]: INFO : Ignition 2.22.0 Oct 28 04:40:25.135314 ignition[1307]: INFO : Stage: files Oct 28 04:40:25.135314 ignition[1307]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 28 04:40:25.135314 ignition[1307]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 28 04:40:25.135314 ignition[1307]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 28 04:40:25.144292 ignition[1307]: INFO : PUT result: OK Oct 28 04:40:25.154971 ignition[1307]: DEBUG : files: compiled without relabeling support, skipping Oct 28 04:40:25.157861 ignition[1307]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 28 04:40:25.157861 ignition[1307]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 28 04:40:25.168656 ignition[1307]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 28 04:40:25.171890 ignition[1307]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 28 04:40:25.175314 unknown[1307]: wrote ssh authorized keys file for user: core Oct 28 04:40:25.177833 ignition[1307]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 28 04:40:25.182040 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/hostname" Oct 28 04:40:25.185768 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/hostname" Oct 28 04:40:25.195738 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 28 04:40:25.200253 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 28 04:40:25.200253 ignition[1307]: INFO : files: op(5): [started] processing unit "var-mnt.mount" Oct 28 04:40:25.200253 ignition[1307]: INFO : files: op(5): op(6): [started] writing unit "var-mnt.mount" at "/sysroot/etc/systemd/system/var-mnt.mount" Oct 28 04:40:25.213023 ignition[1307]: INFO : files: op(5): op(6): [finished] writing unit "var-mnt.mount" at "/sysroot/etc/systemd/system/var-mnt.mount" Oct 28 04:40:25.216939 ignition[1307]: INFO : files: op(5): [finished] processing unit "var-mnt.mount" Oct 28 04:40:25.216939 ignition[1307]: INFO : files: op(7): [started] setting preset to enabled for "var-mnt.mount" Oct 28 04:40:25.216939 ignition[1307]: INFO : files: op(7): [finished] setting preset to enabled for "var-mnt.mount" Oct 28 04:40:25.216939 ignition[1307]: INFO : files: createResultFile: createFiles: op(8): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 28 04:40:25.216939 ignition[1307]: INFO : files: createResultFile: createFiles: op(8): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 28 04:40:25.216939 ignition[1307]: INFO : files: files passed Oct 28 04:40:25.216939 ignition[1307]: INFO : Ignition finished successfully Oct 28 04:40:25.234509 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 28 04:40:25.241515 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 28 04:40:25.252386 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 28 04:40:25.279154 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 28 04:40:25.284646 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 28 04:40:25.302343 initrd-setup-root-after-ignition[1338]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 28 04:40:25.305903 initrd-setup-root-after-ignition[1338]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 28 04:40:25.310221 initrd-setup-root-after-ignition[1342]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 28 04:40:25.316252 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 28 04:40:25.320209 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 28 04:40:25.329435 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 28 04:40:25.403466 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 28 04:40:25.404951 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 28 04:40:25.409431 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 28 04:40:25.416812 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 28 04:40:25.422469 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 28 04:40:25.426096 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 28 04:40:25.468214 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 28 04:40:25.474998 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 28 04:40:25.519552 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Oct 28 04:40:25.519896 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 28 04:40:25.525453 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 28 04:40:25.533021 systemd[1]: Stopped target timers.target - Timer Units. Oct 28 04:40:25.535857 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 28 04:40:25.536130 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 28 04:40:25.548874 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 28 04:40:25.551357 systemd[1]: Stopped target basic.target - Basic System. Oct 28 04:40:25.558156 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 28 04:40:25.561121 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 28 04:40:25.565834 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 28 04:40:25.570928 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 28 04:40:25.578165 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 28 04:40:25.582085 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 28 04:40:25.588529 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 28 04:40:25.591066 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 28 04:40:25.598345 systemd[1]: Stopped target swap.target - Swaps. Oct 28 04:40:25.600605 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 28 04:40:25.601262 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 28 04:40:25.609624 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 28 04:40:25.614444 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 28 04:40:25.617417 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 28 04:40:25.622237 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 28 04:40:25.625085 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 28 04:40:25.625337 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 28 04:40:25.635550 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 28 04:40:25.635996 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 28 04:40:25.641139 systemd[1]: ignition-files.service: Deactivated successfully. Oct 28 04:40:25.641351 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 28 04:40:25.653888 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 28 04:40:25.658131 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 28 04:40:25.663243 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 28 04:40:25.665087 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 28 04:40:25.671583 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 28 04:40:25.675453 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 28 04:40:25.681882 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 28 04:40:25.682443 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 28 04:40:25.705437 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 28 04:40:25.708008 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 28 04:40:25.737671 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 28 04:40:25.745363 ignition[1362]: INFO : Ignition 2.22.0 Oct 28 04:40:25.745363 ignition[1362]: INFO : Stage: umount Oct 28 04:40:25.749644 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 28 04:40:25.750002 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 28 04:40:25.756352 ignition[1362]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 28 04:40:25.756352 ignition[1362]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 28 04:40:25.756352 ignition[1362]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 28 04:40:25.764248 ignition[1362]: INFO : PUT result: OK Oct 28 04:40:25.768886 ignition[1362]: INFO : umount: umount passed Oct 28 04:40:25.772006 ignition[1362]: INFO : Ignition finished successfully Oct 28 04:40:25.774021 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 28 04:40:25.774274 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 28 04:40:25.781499 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 28 04:40:25.781615 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 28 04:40:25.792446 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 28 04:40:25.792565 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 28 04:40:25.798954 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 28 04:40:25.799083 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 28 04:40:25.805243 systemd[1]: Stopped target network.target - Network. Oct 28 04:40:25.807691 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 28 04:40:25.807782 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 28 04:40:25.811821 systemd[1]: Stopped target paths.target - Path Units. Oct 28 04:40:25.814295 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 04:40:25.820328 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 28 04:40:25.823858 systemd[1]: Stopped target slices.target - Slice Units. Oct 28 04:40:25.830383 systemd[1]: Stopped target sockets.target - Socket Units. Oct 28 04:40:25.835745 systemd[1]: iscsid.socket: Deactivated successfully. Oct 28 04:40:25.835838 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 28 04:40:25.838248 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 28 04:40:25.838747 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 28 04:40:25.842471 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 28 04:40:25.842723 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 28 04:40:25.848397 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 28 04:40:25.848488 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 28 04:40:25.854790 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 28 04:40:25.854892 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 28 04:40:25.857746 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 28 04:40:25.863862 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 28 04:40:25.887248 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 28 04:40:25.887437 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 28 04:40:25.903955 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 28 04:40:25.906653 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 28 04:40:25.913903 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 28 04:40:25.919055 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 28 04:40:25.919198 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 28 04:40:25.928595 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 28 04:40:25.936430 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 28 04:40:25.936581 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 28 04:40:25.939699 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 04:40:25.939824 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 28 04:40:25.943338 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 28 04:40:25.943451 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 28 04:40:25.953515 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 28 04:40:25.983443 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 28 04:40:25.985615 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 28 04:40:25.994856 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 28 04:40:25.994966 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 28 04:40:26.003052 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 28 04:40:26.003171 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 28 04:40:26.009550 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 28 04:40:26.009705 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 28 04:40:26.016892 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 28 04:40:26.017038 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 28 04:40:26.024457 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 28 04:40:26.024594 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 28 04:40:26.034024 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 28 04:40:26.039189 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 28 04:40:26.039312 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Oct 28 04:40:26.049326 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 04:40:26.052945 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 28 04:40:26.062265 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 28 04:40:26.062392 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 28 04:40:26.065623 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 28 04:40:26.065738 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 28 04:40:26.076294 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 04:40:26.076418 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 28 04:40:26.106580 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 28 04:40:26.107803 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 28 04:40:26.119250 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 28 04:40:26.119478 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 28 04:40:26.126539 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 28 04:40:26.137451 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 28 04:40:26.172519 systemd[1]: Switching root. Oct 28 04:40:26.217283 systemd-journald[357]: Journal stopped Oct 28 04:40:28.204647 systemd-journald[357]: Received SIGTERM from PID 1 (systemd). Oct 28 04:40:28.204762 kernel: SELinux: policy capability network_peer_controls=1 Oct 28 04:40:28.204814 kernel: SELinux: policy capability open_perms=1 Oct 28 04:40:28.204847 kernel: SELinux: policy capability extended_socket_class=1 Oct 28 04:40:28.204877 kernel: SELinux: policy capability always_check_network=0 Oct 28 04:40:28.204944 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 28 04:40:28.204983 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 28 04:40:28.205016 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 28 04:40:28.205048 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 28 04:40:28.205080 kernel: SELinux: policy capability userspace_initial_context=0 Oct 28 04:40:28.205170 kernel: audit: type=1403 audit(1761626426.360:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 28 04:40:28.205215 systemd[1]: Successfully loaded SELinux policy in 91.144ms. Oct 28 04:40:28.205275 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 15.961ms. Oct 28 04:40:28.205311 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +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 -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Oct 28 04:40:28.205346 systemd[1]: Detected virtualization amazon. Oct 28 04:40:28.205378 systemd[1]: Detected architecture arm64. Oct 28 04:40:28.205409 systemd[1]: Detected first boot. Oct 28 04:40:28.205442 systemd[1]: Hostname set to . Oct 28 04:40:28.205476 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 28 04:40:28.205517 zram_generator::config[1405]: No configuration found. Oct 28 04:40:28.205553 kernel: NET: Registered PF_VSOCK protocol family Oct 28 04:40:28.205584 systemd[1]: Populated /etc with preset unit settings. Oct 28 04:40:28.205618 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 28 04:40:28.205655 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 28 04:40:28.205688 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 28 04:40:28.205724 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 28 04:40:28.205758 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 28 04:40:28.205790 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 28 04:40:28.205822 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 28 04:40:28.205859 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 28 04:40:28.205893 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 28 04:40:28.205927 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 28 04:40:28.205958 systemd[1]: Created slice user.slice - User and Session Slice. Oct 28 04:40:28.205990 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 28 04:40:28.206022 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 28 04:40:28.206055 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 28 04:40:28.206101 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 28 04:40:28.206200 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 28 04:40:28.206237 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 28 04:40:28.206271 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 28 04:40:28.206305 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 28 04:40:28.206341 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 28 04:40:28.206371 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 28 04:40:28.206401 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 28 04:40:28.206432 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 28 04:40:28.206462 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 28 04:40:28.206492 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 28 04:40:28.206524 systemd[1]: Reached target slices.target - Slice Units. Oct 28 04:40:28.206558 systemd[1]: Reached target swap.target - Swaps. Oct 28 04:40:28.206596 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 28 04:40:28.206626 systemd[1]: Listening on rpcbind.socket - RPCbind Server Activation Socket. Oct 28 04:40:28.206658 systemd[1]: Reached target rpcbind.target - RPC Port Mapper. Oct 28 04:40:28.206688 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 28 04:40:28.206720 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 28 04:40:28.206750 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 28 04:40:28.206785 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 28 04:40:28.206819 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 28 04:40:28.206849 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 28 04:40:28.206882 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 28 04:40:28.206915 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 28 04:40:28.206945 systemd[1]: Mounting media.mount - External Media Directory... Oct 28 04:40:28.206977 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 28 04:40:28.207009 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 28 04:40:28.207044 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 28 04:40:28.207076 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). Oct 28 04:40:28.207188 systemd[1]: Reached target machines.target - Containers. Oct 28 04:40:28.207230 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 28 04:40:28.207262 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 28 04:40:28.207292 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 28 04:40:28.207330 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 28 04:40:28.207363 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 28 04:40:28.207392 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 28 04:40:28.207424 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 28 04:40:28.207454 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 28 04:40:28.207486 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 28 04:40:28.207516 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 28 04:40:28.207551 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 28 04:40:28.207580 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 28 04:40:28.207612 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 28 04:40:28.207642 systemd[1]: Stopped systemd-fsck-usr.service. Oct 28 04:40:28.207675 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). Oct 28 04:40:28.207705 kernel: fuse: init (API version 7.41) Oct 28 04:40:28.207734 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 28 04:40:28.207769 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 28 04:40:28.207799 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 28 04:40:28.207832 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 28 04:40:28.207864 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 28 04:40:28.207897 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 28 04:40:28.207931 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 28 04:40:28.207961 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 28 04:40:28.207992 systemd[1]: Mounted media.mount - External Media Directory. Oct 28 04:40:28.208024 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 28 04:40:28.208074 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 28 04:40:28.208167 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 28 04:40:28.208217 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 28 04:40:28.208250 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 28 04:40:28.208280 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 28 04:40:28.208310 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 28 04:40:28.208340 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 28 04:40:28.208371 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 28 04:40:28.208401 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 28 04:40:28.208437 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 28 04:40:28.208466 kernel: ACPI: bus type drm_connector registered Oct 28 04:40:28.208499 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 04:40:28.208528 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 28 04:40:28.208562 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 28 04:40:28.208592 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 28 04:40:28.208624 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 28 04:40:28.208654 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 28 04:40:28.208684 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 28 04:40:28.208714 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 28 04:40:28.208745 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 28 04:40:28.208779 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 28 04:40:28.208813 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 28 04:40:28.208846 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 28 04:40:28.208877 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 28 04:40:28.208909 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 28 04:40:28.208941 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 28 04:40:28.209029 systemd-journald[1498]: Collecting audit messages is disabled. Oct 28 04:40:28.209085 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 28 04:40:28.209163 systemd-journald[1498]: Journal started Oct 28 04:40:28.209221 systemd-journald[1498]: Runtime Journal (/run/log/journal/ec2a7bdbd50d68ca448722c407507c8c) is 8M, max 75.3M, 67.3M free. Oct 28 04:40:27.417611 systemd[1]: Queued start job for default target multi-user.target. Oct 28 04:40:27.427207 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Oct 28 04:40:27.428256 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 28 04:40:28.216189 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 28 04:40:28.221363 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 28 04:40:28.234500 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 28 04:40:28.241171 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 28 04:40:28.247999 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 28 04:40:28.262101 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 28 04:40:28.280131 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 28 04:40:28.290152 systemd[1]: Started systemd-journald.service - Journal Service. Oct 28 04:40:28.307238 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 28 04:40:28.314347 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 28 04:40:28.347466 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 28 04:40:28.358857 kernel: loop1: detected capacity change from 0 to 61504 Oct 28 04:40:28.376219 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 28 04:40:28.382980 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 28 04:40:28.392475 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 28 04:40:28.397362 systemd-tmpfiles[1523]: ACLs are not supported, ignoring. Oct 28 04:40:28.397886 systemd-tmpfiles[1523]: ACLs are not supported, ignoring. Oct 28 04:40:28.418323 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 28 04:40:28.427414 systemd-journald[1498]: Time spent on flushing to /var/log/journal/ec2a7bdbd50d68ca448722c407507c8c is 58.817ms for 917 entries. Oct 28 04:40:28.427414 systemd-journald[1498]: System Journal (/var/log/journal/ec2a7bdbd50d68ca448722c407507c8c) is 8M, max 588.1M, 580.1M free. Oct 28 04:40:28.528374 systemd-journald[1498]: Received client request to flush runtime journal. Oct 28 04:40:28.429919 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 28 04:40:28.440876 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 28 04:40:28.450308 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 28 04:40:28.474010 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 28 04:40:28.485602 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 28 04:40:28.535208 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 28 04:40:28.545690 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 28 04:40:28.548264 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 28 04:40:28.580455 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 28 04:40:28.588695 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 28 04:40:28.599591 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 28 04:40:28.616931 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 28 04:40:28.653398 systemd-tmpfiles[1563]: ACLs are not supported, ignoring. Oct 28 04:40:28.653436 systemd-tmpfiles[1563]: ACLs are not supported, ignoring. Oct 28 04:40:28.662429 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 28 04:40:28.716185 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 28 04:40:28.772158 kernel: loop2: detected capacity change from 0 to 119400 Oct 28 04:40:28.819164 kernel: loop3: detected capacity change from 0 to 100192 Oct 28 04:40:28.853306 systemd-resolved[1562]: Positive Trust Anchors: Oct 28 04:40:28.853806 systemd-resolved[1562]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 04:40:28.853820 systemd-resolved[1562]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 28 04:40:28.853881 systemd-resolved[1562]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 28 04:40:28.864155 kernel: loop4: detected capacity change from 0 to 61504 Oct 28 04:40:28.876473 systemd-resolved[1562]: Using system hostname 'nfs2'. Oct 28 04:40:28.879747 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 28 04:40:28.882378 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 28 04:40:28.891197 kernel: loop5: detected capacity change from 0 to 119400 Oct 28 04:40:28.909201 kernel: loop6: detected capacity change from 0 to 100192 Oct 28 04:40:28.926359 (sd-merge)[1576]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-ami.raw'. Oct 28 04:40:28.933075 (sd-merge)[1576]: Merged extensions into '/usr'. Oct 28 04:40:28.941275 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 28 04:40:28.946949 systemd[1]: Starting ensure-sysext.service... Oct 28 04:40:28.953523 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 28 04:40:28.981355 systemd[1]: Reload requested from client PID 1578 ('systemctl') (unit ensure-sysext.service)... Oct 28 04:40:28.981580 systemd[1]: Reloading... Oct 28 04:40:29.028806 systemd-tmpfiles[1579]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 28 04:40:29.028882 systemd-tmpfiles[1579]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 28 04:40:29.030537 systemd-tmpfiles[1579]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 28 04:40:29.031046 systemd-tmpfiles[1579]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 28 04:40:29.034922 systemd-tmpfiles[1579]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 28 04:40:29.037951 systemd-tmpfiles[1579]: ACLs are not supported, ignoring. Oct 28 04:40:29.038137 systemd-tmpfiles[1579]: ACLs are not supported, ignoring. Oct 28 04:40:29.051799 systemd-tmpfiles[1579]: Detected autofs mount point /boot during canonicalization of boot. Oct 28 04:40:29.051818 systemd-tmpfiles[1579]: Skipping /boot Oct 28 04:40:29.075499 systemd-tmpfiles[1579]: Detected autofs mount point /boot during canonicalization of boot. Oct 28 04:40:29.075688 systemd-tmpfiles[1579]: Skipping /boot Oct 28 04:40:29.194153 zram_generator::config[1612]: No configuration found. Oct 28 04:40:29.622234 systemd[1]: Reloading finished in 639 ms. Oct 28 04:40:29.647211 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 28 04:40:29.684892 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 28 04:40:29.703389 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 28 04:40:29.709574 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 28 04:40:29.717539 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 28 04:40:29.730559 systemd[1]: Starting rpcbind.service - RPC Bind... Oct 28 04:40:29.737272 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 28 04:40:29.749684 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 28 04:40:29.758701 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 28 04:40:29.769365 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 28 04:40:29.786561 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 28 04:40:29.794125 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 28 04:40:29.800528 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 28 04:40:29.803093 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 28 04:40:29.803381 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). Oct 28 04:40:29.816961 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 28 04:40:29.818357 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 28 04:40:29.818557 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). Oct 28 04:40:29.829744 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). Oct 28 04:40:29.831674 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 28 04:40:29.837363 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 28 04:40:29.839930 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 28 04:40:29.840249 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). Oct 28 04:40:29.840579 systemd[1]: Reached target time-set.target - System Time Set. Oct 28 04:40:29.876032 systemd[1]: Finished ensure-sysext.service. Oct 28 04:40:29.901985 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 28 04:40:29.909961 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 28 04:40:29.923016 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 28 04:40:29.925716 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 28 04:40:29.930666 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 28 04:40:29.939754 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 04:40:29.941956 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 28 04:40:29.948041 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 28 04:40:29.951846 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 28 04:40:29.953423 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 28 04:40:29.966351 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 28 04:40:29.979231 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 28 04:40:30.023230 systemd-udevd[1668]: Using default interface naming scheme 'v257'. Oct 28 04:40:30.049723 augenrules[1700]: No rules Oct 28 04:40:30.050701 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 04:40:30.053233 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 28 04:40:30.088604 (rpcbind)[1666]: rpcbind.service: Referenced but unset environment variable evaluates to an empty string: RPCBIND_OPTIONS Oct 28 04:40:30.109016 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 28 04:40:30.119170 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 28 04:40:30.122338 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 28 04:40:30.127649 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). Oct 28 04:40:30.152689 systemd[1]: Started rpcbind.service - RPC Bind. Oct 28 04:40:30.296537 (udev-worker)[1711]: Network interface NamePolicy= disabled on kernel command line. Oct 28 04:40:30.327521 systemd-networkd[1708]: lo: Link UP Oct 28 04:40:30.327546 systemd-networkd[1708]: lo: Gained carrier Oct 28 04:40:30.332023 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 28 04:40:30.334937 systemd[1]: Reached target network.target - Network. Oct 28 04:40:30.342237 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 28 04:40:30.349248 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 28 04:40:30.407741 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 28 04:40:30.435776 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 28 04:40:30.493538 systemd-networkd[1708]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 28 04:40:30.493562 systemd-networkd[1708]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 28 04:40:30.498153 systemd-networkd[1708]: eth0: Link UP Oct 28 04:40:30.498444 systemd-networkd[1708]: eth0: Gained carrier Oct 28 04:40:30.498482 systemd-networkd[1708]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 28 04:40:30.512299 systemd-networkd[1708]: eth0: DHCPv4 address 172.31.24.152/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 28 04:40:30.626455 ldconfig[1665]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 28 04:40:30.642266 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 28 04:40:30.650547 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 28 04:40:30.697230 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 28 04:40:30.700503 systemd[1]: Reached target sysinit.target - System Initialization. Oct 28 04:40:30.703230 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 28 04:40:30.706099 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 04:40:30.710353 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 28 04:40:30.713302 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 28 04:40:30.716365 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 28 04:40:30.719219 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 28 04:40:30.719279 systemd[1]: Reached target paths.target - Path Units. Oct 28 04:40:30.721469 systemd[1]: Reached target timers.target - Timer Units. Oct 28 04:40:30.726982 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 28 04:40:30.733239 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 28 04:40:30.744082 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 28 04:40:30.747534 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Oct 28 04:40:30.750711 systemd[1]: Reached target ssh-access.target - SSH Access Available. Oct 28 04:40:30.778302 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 28 04:40:30.781405 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 28 04:40:30.785232 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 28 04:40:30.799081 systemd[1]: Reached target sockets.target - Socket Units. Oct 28 04:40:30.801551 systemd[1]: Reached target basic.target - Basic System. Oct 28 04:40:30.803768 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 28 04:40:30.803820 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 28 04:40:30.806842 systemd[1]: Starting containerd.service - containerd container runtime... Oct 28 04:40:30.817517 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Oct 28 04:40:30.824555 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 28 04:40:30.831307 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 28 04:40:30.837469 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 28 04:40:30.844963 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 28 04:40:30.847277 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). Oct 28 04:40:30.852210 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 28 04:40:30.865687 systemd[1]: Started ntpd.service - Network Time Service. Oct 28 04:40:30.871410 systemd[1]: Starting setup-oem.service - Setup OEM... Oct 28 04:40:30.875735 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 28 04:40:30.883414 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 28 04:40:30.901525 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 28 04:40:30.907441 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 28 04:40:30.908374 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 28 04:40:30.912508 systemd[1]: Starting update-engine.service - Update Engine... Oct 28 04:40:30.952131 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 28 04:40:30.978619 jq[1822]: false Oct 28 04:40:30.994222 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 28 04:40:30.997742 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 28 04:40:31.000259 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 28 04:40:31.041798 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 28 04:40:31.045208 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 28 04:40:31.098332 jq[1842]: true Oct 28 04:40:31.121510 dbus-daemon[1817]: [system] SELinux support is enabled Oct 28 04:40:31.117664 systemd[1]: motdgen.service: Deactivated successfully. Oct 28 04:40:31.118100 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 28 04:40:31.121859 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 28 04:40:31.128895 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). Oct 28 04:40:31.128938 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 28 04:40:31.131894 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). Oct 28 04:40:31.131931 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 28 04:40:31.147186 systemd[1]: Finished setup-oem.service - Setup OEM. Oct 28 04:40:31.153647 update_engine[1840]: I20251028 04:40:31.151166 1840 main.cc:92] Flatcar Update Engine starting Oct 28 04:40:31.171459 extend-filesystems[1823]: Found /dev/nvme0n1p6 Oct 28 04:40:31.172177 dbus-daemon[1817]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1708 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Oct 28 04:40:31.179824 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Oct 28 04:40:31.190088 jq[1874]: true Oct 28 04:40:31.210709 extend-filesystems[1823]: Found /dev/nvme0n1p9 Oct 28 04:40:31.212850 update_engine[1840]: I20251028 04:40:31.210371 1840 update_check_scheduler.cc:74] Next update check in 7m15s Oct 28 04:40:31.197336 systemd[1]: Started update-engine.service - Update Engine. Oct 28 04:40:31.221461 extend-filesystems[1823]: Checking size of /dev/nvme0n1p9 Oct 28 04:40:31.293520 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 28 04:40:31.316422 extend-filesystems[1823]: Resized partition /dev/nvme0n1p9 Oct 28 04:40:31.326426 ntpd[1835]: ntpd 4.2.8p18@1.4062-o Tue Oct 28 02:53:21 UTC 2025 (1): Starting Oct 28 04:40:31.330960 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: ntpd 4.2.8p18@1.4062-o Tue Oct 28 02:53:21 UTC 2025 (1): Starting Oct 28 04:40:31.330960 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 28 04:40:31.330960 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: ---------------------------------------------------- Oct 28 04:40:31.330960 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: ntp-4 is maintained by Network Time Foundation, Oct 28 04:40:31.330960 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 28 04:40:31.330960 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: corporation. Support and training for ntp-4 are Oct 28 04:40:31.330960 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: available at https://www.nwtime.org/support Oct 28 04:40:31.330960 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: ---------------------------------------------------- Oct 28 04:40:31.326535 ntpd[1835]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 28 04:40:31.326554 ntpd[1835]: ---------------------------------------------------- Oct 28 04:40:31.326571 ntpd[1835]: ntp-4 is maintained by Network Time Foundation, Oct 28 04:40:31.326587 ntpd[1835]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 28 04:40:31.326603 ntpd[1835]: corporation. Support and training for ntp-4 are Oct 28 04:40:31.326620 ntpd[1835]: available at https://www.nwtime.org/support Oct 28 04:40:31.326636 ntpd[1835]: ---------------------------------------------------- Oct 28 04:40:31.340297 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: proto: precision = 0.096 usec (-23) Oct 28 04:40:31.340297 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: basedate set to 2025-10-16 Oct 28 04:40:31.340297 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: gps base set to 2025-10-19 (week 2389) Oct 28 04:40:31.340417 extend-filesystems[1906]: resize2fs 1.47.3 (8-Jul-2025) Oct 28 04:40:31.338591 ntpd[1835]: proto: precision = 0.096 usec (-23) Oct 28 04:40:31.339035 ntpd[1835]: basedate set to 2025-10-16 Oct 28 04:40:31.339060 ntpd[1835]: gps base set to 2025-10-19 (week 2389) Oct 28 04:40:31.348331 ntpd[1835]: Listen and drop on 0 v6wildcard [::]:123 Oct 28 04:40:31.349347 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: Listen and drop on 0 v6wildcard [::]:123 Oct 28 04:40:31.349347 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 28 04:40:31.349347 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: Listen normally on 2 lo 127.0.0.1:123 Oct 28 04:40:31.349347 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: Listen normally on 3 eth0 172.31.24.152:123 Oct 28 04:40:31.349347 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: Listen normally on 4 lo [::1]:123 Oct 28 04:40:31.349347 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: bind(21) AF_INET6 [fe80::4d0:44ff:fe56:e375%2]:123 flags 0x811 failed: Cannot assign requested address Oct 28 04:40:31.349347 ntpd[1835]: 28 Oct 04:40:31 ntpd[1835]: unable to create socket on eth0 (5) for [fe80::4d0:44ff:fe56:e375%2]:123 Oct 28 04:40:31.348398 ntpd[1835]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 28 04:40:31.348692 ntpd[1835]: Listen normally on 2 lo 127.0.0.1:123 Oct 28 04:40:31.348738 ntpd[1835]: Listen normally on 3 eth0 172.31.24.152:123 Oct 28 04:40:31.348785 ntpd[1835]: Listen normally on 4 lo [::1]:123 Oct 28 04:40:31.348833 ntpd[1835]: bind(21) AF_INET6 [fe80::4d0:44ff:fe56:e375%2]:123 flags 0x811 failed: Cannot assign requested address Oct 28 04:40:31.348869 ntpd[1835]: unable to create socket on eth0 (5) for [fe80::4d0:44ff:fe56:e375%2]:123 Oct 28 04:40:31.355275 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 1617920 to 2604027 blocks Oct 28 04:40:31.372314 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 2604027 Oct 28 04:40:31.402325 extend-filesystems[1906]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Oct 28 04:40:31.402325 extend-filesystems[1906]: old_desc_blocks = 1, new_desc_blocks = 2 Oct 28 04:40:31.402325 extend-filesystems[1906]: The filesystem on /dev/nvme0n1p9 is now 2604027 (4k) blocks long. Oct 28 04:40:31.416897 extend-filesystems[1823]: Resized filesystem in /dev/nvme0n1p9 Oct 28 04:40:31.410814 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 28 04:40:31.416018 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 28 04:40:31.466057 coreos-metadata[1812]: Oct 28 04:40:31.462 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 28 04:40:31.466057 coreos-metadata[1812]: Oct 28 04:40:31.465 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Oct 28 04:40:31.466635 coreos-metadata[1812]: Oct 28 04:40:31.466 INFO Fetch successful Oct 28 04:40:31.466635 coreos-metadata[1812]: Oct 28 04:40:31.466 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Oct 28 04:40:31.470575 coreos-metadata[1812]: Oct 28 04:40:31.467 INFO Fetch successful Oct 28 04:40:31.470575 coreos-metadata[1812]: Oct 28 04:40:31.467 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Oct 28 04:40:31.471604 coreos-metadata[1812]: Oct 28 04:40:31.471 INFO Fetch successful Oct 28 04:40:31.471604 coreos-metadata[1812]: Oct 28 04:40:31.471 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Oct 28 04:40:31.472666 coreos-metadata[1812]: Oct 28 04:40:31.472 INFO Fetch successful Oct 28 04:40:31.472666 coreos-metadata[1812]: Oct 28 04:40:31.472 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Oct 28 04:40:31.475234 coreos-metadata[1812]: Oct 28 04:40:31.473 INFO Fetch failed with 404: resource not found Oct 28 04:40:31.475234 coreos-metadata[1812]: Oct 28 04:40:31.475 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Oct 28 04:40:31.478846 bash[1926]: Updated "/home/core/.ssh/authorized_keys" Oct 28 04:40:31.479087 coreos-metadata[1812]: Oct 28 04:40:31.476 INFO Fetch successful Oct 28 04:40:31.479087 coreos-metadata[1812]: Oct 28 04:40:31.476 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Oct 28 04:40:31.479087 coreos-metadata[1812]: Oct 28 04:40:31.478 INFO Fetch successful Oct 28 04:40:31.479087 coreos-metadata[1812]: Oct 28 04:40:31.478 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Oct 28 04:40:31.482789 coreos-metadata[1812]: Oct 28 04:40:31.480 INFO Fetch successful Oct 28 04:40:31.483452 coreos-metadata[1812]: Oct 28 04:40:31.483 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Oct 28 04:40:31.483217 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 28 04:40:31.493607 systemd[1]: Starting sshkeys.service... Oct 28 04:40:31.495216 coreos-metadata[1812]: Oct 28 04:40:31.487 INFO Fetch successful Oct 28 04:40:31.495216 coreos-metadata[1812]: Oct 28 04:40:31.487 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Oct 28 04:40:31.495216 coreos-metadata[1812]: Oct 28 04:40:31.488 INFO Fetch successful Oct 28 04:40:31.526544 systemd-coredump[1910]: Process 1835 (ntpd) of user 0 terminated abnormally with signal 11/SEGV, processing... Oct 28 04:40:31.556892 systemd[1]: Created slice system-systemd\x2dcoredump.slice - Slice /system/systemd-coredump. Oct 28 04:40:31.568547 systemd[1]: Started systemd-coredump@0-1910-0.service - Process Core Dump (PID 1910/UID 0). Oct 28 04:40:31.599389 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Oct 28 04:40:31.604505 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Oct 28 04:40:31.664223 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Oct 28 04:40:31.667846 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 28 04:40:31.812309 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Oct 28 04:40:31.843284 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 28 04:40:31.850794 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 28 04:40:31.928378 coreos-metadata[1936]: Oct 28 04:40:31.926 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 28 04:40:31.930823 coreos-metadata[1936]: Oct 28 04:40:31.930 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Oct 28 04:40:31.933689 coreos-metadata[1936]: Oct 28 04:40:31.932 INFO Fetch successful Oct 28 04:40:31.933689 coreos-metadata[1936]: Oct 28 04:40:31.933 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Oct 28 04:40:31.936061 coreos-metadata[1936]: Oct 28 04:40:31.935 INFO Fetch successful Oct 28 04:40:31.936613 containerd[1858]: time="2025-10-28T04:40:31Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Oct 28 04:40:31.944246 unknown[1936]: wrote ssh authorized keys file for user: core Oct 28 04:40:31.961047 containerd[1858]: time="2025-10-28T04:40:31.960613402Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Oct 28 04:40:31.979225 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 28 04:40:32.040695 containerd[1858]: time="2025-10-28T04:40:32.040415383Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="14.928µs" Oct 28 04:40:32.046197 containerd[1858]: time="2025-10-28T04:40:32.042020875Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 28 04:40:32.046197 containerd[1858]: time="2025-10-28T04:40:32.046074499Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 28 04:40:32.050064 containerd[1858]: time="2025-10-28T04:40:32.047740543Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 28 04:40:32.050064 containerd[1858]: time="2025-10-28T04:40:32.047813179Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 28 04:40:32.050064 containerd[1858]: time="2025-10-28T04:40:32.047867755Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 28 04:40:32.050064 containerd[1858]: time="2025-10-28T04:40:32.047982067Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 28 04:40:32.050064 containerd[1858]: time="2025-10-28T04:40:32.048008731Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 28 04:40:32.056852 update-ssh-keys[1953]: Updated "/home/core/.ssh/authorized_keys" Oct 28 04:40:32.060903 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Oct 28 04:40:32.073886 systemd[1]: Finished sshkeys.service. Oct 28 04:40:32.092194 containerd[1858]: time="2025-10-28T04:40:32.092081839Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 28 04:40:32.092194 containerd[1858]: time="2025-10-28T04:40:32.092181151Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 28 04:40:32.092496 containerd[1858]: time="2025-10-28T04:40:32.092215087Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 28 04:40:32.092496 containerd[1858]: time="2025-10-28T04:40:32.092240455Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 28 04:40:32.092496 containerd[1858]: time="2025-10-28T04:40:32.092463139Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 28 04:40:32.093565 containerd[1858]: time="2025-10-28T04:40:32.092875015Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 28 04:40:32.093565 containerd[1858]: time="2025-10-28T04:40:32.092937367Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 28 04:40:32.093565 containerd[1858]: time="2025-10-28T04:40:32.092961607Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 28 04:40:32.095127 containerd[1858]: time="2025-10-28T04:40:32.093959611Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 28 04:40:32.096201 containerd[1858]: time="2025-10-28T04:40:32.096096079Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 28 04:40:32.096515 containerd[1858]: time="2025-10-28T04:40:32.096380023Z" level=info msg="metadata content store policy set" policy=shared Oct 28 04:40:32.100718 systemd-networkd[1708]: eth0: Gained IPv6LL Oct 28 04:40:32.109095 containerd[1858]: time="2025-10-28T04:40:32.109023775Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 28 04:40:32.109277 containerd[1858]: time="2025-10-28T04:40:32.109147651Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 28 04:40:32.109277 containerd[1858]: time="2025-10-28T04:40:32.109199671Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 28 04:40:32.109277 containerd[1858]: time="2025-10-28T04:40:32.109229431Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 28 04:40:32.109277 containerd[1858]: time="2025-10-28T04:40:32.109266655Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 28 04:40:32.109431 containerd[1858]: time="2025-10-28T04:40:32.109295791Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 28 04:40:32.109431 containerd[1858]: time="2025-10-28T04:40:32.109327987Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 28 04:40:32.109431 containerd[1858]: time="2025-10-28T04:40:32.109357495Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 28 04:40:32.109431 containerd[1858]: time="2025-10-28T04:40:32.109383559Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 28 04:40:32.109431 containerd[1858]: time="2025-10-28T04:40:32.109412299Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 28 04:40:32.109635 containerd[1858]: time="2025-10-28T04:40:32.109438939Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 28 04:40:32.109635 containerd[1858]: time="2025-10-28T04:40:32.109478995Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.109707127Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.109759843Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.109799191Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.109830283Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.109857967Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.109883179Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.109910023Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.109935559Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.109961875Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.109988455Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 28 04:40:32.111866 containerd[1858]: time="2025-10-28T04:40:32.110013391Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 28 04:40:32.120784 containerd[1858]: time="2025-10-28T04:40:32.117158971Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 28 04:40:32.120784 containerd[1858]: time="2025-10-28T04:40:32.117217195Z" level=info msg="Start snapshots syncer" Oct 28 04:40:32.120784 containerd[1858]: time="2025-10-28T04:40:32.117272695Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 28 04:40:32.112367 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.117644767Z" 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\"}" Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.117726331Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.117832291Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118057111Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118097887Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118163659Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118197751Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118229143Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118255327Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118280851Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118327627Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118356367Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118385395Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 28 04:40:32.121051 containerd[1858]: time="2025-10-28T04:40:32.118432075Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.121186375Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.121235755Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.121266895Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.121290979Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.121320691Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.121348243Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.121599631Z" level=info msg="runtime interface created" Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.121695331Z" level=info msg="created NRI interface" Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.121965235Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.125188819Z" level=info msg="Connect containerd service" Oct 28 04:40:32.126638 containerd[1858]: time="2025-10-28T04:40:32.125303515Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 28 04:40:32.121424 systemd[1]: Reached target network-online.target - Network is Online. Oct 28 04:40:32.127549 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Oct 28 04:40:32.133700 containerd[1858]: time="2025-10-28T04:40:32.133630327Z" 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" Oct 28 04:40:32.134942 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 28 04:40:32.141856 systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... Oct 28 04:40:32.166822 systemd[1]: Starting rpc-statd.service - NFS status monitor for NFSv2/3 locking.... Oct 28 04:40:32.204633 sm-notify[1982]: Version 2.7.1 starting Oct 28 04:40:32.229314 locksmithd[1887]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 28 04:40:32.236491 systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. Oct 28 04:40:32.259946 rpc.statd[2001]: Version 2.7.1 starting Oct 28 04:40:32.259966 rpc.statd[2001]: Flags: TI-RPC Oct 28 04:40:32.263867 rpc.statd[2001]: Failed to read /var/lib/nfs/state: Success Oct 28 04:40:32.263889 rpc.statd[2001]: Initializing NSM state Oct 28 04:40:32.275702 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 28 04:40:32.293504 systemd[1]: Started rpc-statd.service - NFS status monitor for NFSv2/3 locking.. Oct 28 04:40:32.306664 systemd[1]: Mounting var-mnt.mount - NFS Client... Oct 28 04:40:32.407079 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 28 04:40:32.443148 kernel: netfs: FS-Cache loaded Oct 28 04:40:32.488236 kernel: RPC: Registered named UNIX socket transport module. Oct 28 04:40:32.488366 kernel: RPC: Registered udp transport module. Oct 28 04:40:32.491192 kernel: RPC: Registered tcp transport module. Oct 28 04:40:32.491319 kernel: RPC: Registered tcp-with-tls transport module. Oct 28 04:40:32.493765 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Oct 28 04:40:32.546147 amazon-ssm-agent[1980]: Initializing new seelog logger Oct 28 04:40:32.556246 amazon-ssm-agent[1980]: New Seelog Logger Creation Complete Oct 28 04:40:32.556246 amazon-ssm-agent[1980]: 2025/10/28 04:40:32 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 28 04:40:32.556246 amazon-ssm-agent[1980]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 28 04:40:32.559479 amazon-ssm-agent[1980]: 2025/10/28 04:40:32 processing appconfig overrides Oct 28 04:40:32.564283 amazon-ssm-agent[1980]: 2025/10/28 04:40:32 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 28 04:40:32.564483 amazon-ssm-agent[1980]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 28 04:40:32.564741 amazon-ssm-agent[1980]: 2025/10/28 04:40:32 processing appconfig overrides Oct 28 04:40:32.566481 amazon-ssm-agent[1980]: 2025/10/28 04:40:32 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 28 04:40:32.567613 amazon-ssm-agent[1980]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 28 04:40:32.568759 amazon-ssm-agent[1980]: 2025/10/28 04:40:32 processing appconfig overrides Oct 28 04:40:32.574328 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.5637 INFO Proxy environment variables: Oct 28 04:40:32.590158 amazon-ssm-agent[1980]: 2025/10/28 04:40:32 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 28 04:40:32.590158 amazon-ssm-agent[1980]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 28 04:40:32.590158 amazon-ssm-agent[1980]: 2025/10/28 04:40:32 processing appconfig overrides Oct 28 04:40:32.601879 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 28 04:40:32.679364 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.5641 INFO no_proxy: Oct 28 04:40:32.783867 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.5641 INFO https_proxy: Oct 28 04:40:32.787190 containerd[1858]: time="2025-10-28T04:40:32.786452350Z" level=info msg="Start subscribing containerd event" Oct 28 04:40:32.787190 containerd[1858]: time="2025-10-28T04:40:32.786559450Z" level=info msg="Start recovering state" Oct 28 04:40:32.787190 containerd[1858]: time="2025-10-28T04:40:32.786692062Z" level=info msg="Start event monitor" Oct 28 04:40:32.787190 containerd[1858]: time="2025-10-28T04:40:32.786718522Z" level=info msg="Start cni network conf syncer for default" Oct 28 04:40:32.787190 containerd[1858]: time="2025-10-28T04:40:32.786741154Z" level=info msg="Start streaming server" Oct 28 04:40:32.787190 containerd[1858]: time="2025-10-28T04:40:32.786912226Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 28 04:40:32.787190 containerd[1858]: time="2025-10-28T04:40:32.786933778Z" level=info msg="runtime interface starting up..." Oct 28 04:40:32.787190 containerd[1858]: time="2025-10-28T04:40:32.786949450Z" level=info msg="starting plugins..." Oct 28 04:40:32.787190 containerd[1858]: time="2025-10-28T04:40:32.786980206Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 28 04:40:32.800289 containerd[1858]: time="2025-10-28T04:40:32.799800035Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 28 04:40:32.800289 containerd[1858]: time="2025-10-28T04:40:32.800150111Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 28 04:40:32.805474 systemd[1]: Started containerd.service - containerd container runtime. Oct 28 04:40:32.810563 containerd[1858]: time="2025-10-28T04:40:32.805524155Z" level=info msg="containerd successfully booted in 0.870206s" Oct 28 04:40:32.826230 systemd-logind[1839]: Watching system buttons on /dev/input/event0 (Power Button) Oct 28 04:40:32.828346 systemd-logind[1839]: Watching system buttons on /dev/input/event1 (Sleep Button) Oct 28 04:40:32.833212 systemd-logind[1839]: New seat seat0. Oct 28 04:40:32.841101 systemd[1]: Started systemd-logind.service - User Login Management. Oct 28 04:40:32.883147 kernel: NFS: Registering the id_resolver key type Oct 28 04:40:32.883240 kernel: Key type id_resolver registered Oct 28 04:40:32.883274 kernel: Key type id_legacy registered Oct 28 04:40:32.887464 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.5641 INFO http_proxy: Oct 28 04:40:32.986786 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.5661 INFO Checking if agent identity type OnPrem can be assumed Oct 28 04:40:33.088222 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.5663 INFO Checking if agent identity type EC2 can be assumed Oct 28 04:40:33.100624 systemd[1]: Mounted var-mnt.mount - NFS Client. Oct 28 04:40:33.104699 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 28 04:40:33.184634 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Oct 28 04:40:33.188171 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.9838 INFO Agent will take identity from EC2 Oct 28 04:40:33.210369 dbus-daemon[1817]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 28 04:40:33.222662 dbus-daemon[1817]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=1882 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Oct 28 04:40:33.233020 systemd[1]: Starting polkit.service - Authorization Manager... Oct 28 04:40:33.290153 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.9873 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.3.0.0 Oct 28 04:40:33.298640 nfsrahead[2088]: setting /var/mnt readahead to 128 Oct 28 04:40:33.386210 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.9873 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Oct 28 04:40:33.411716 amazon-ssm-agent[1980]: 2025/10/28 04:40:33 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 28 04:40:33.411716 amazon-ssm-agent[1980]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 28 04:40:33.412255 amazon-ssm-agent[1980]: 2025/10/28 04:40:33 processing appconfig overrides Oct 28 04:40:33.451945 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.9873 INFO [amazon-ssm-agent] Starting Core Agent Oct 28 04:40:33.452279 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.9874 INFO [amazon-ssm-agent] Registrar detected. Attempting registration Oct 28 04:40:33.452279 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.9874 INFO [Registrar] Starting registrar module Oct 28 04:40:33.452279 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.9910 INFO [EC2Identity] Checking disk for registration info Oct 28 04:40:33.452612 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.9911 INFO [EC2Identity] No registration info found for ec2 instance, attempting registration Oct 28 04:40:33.452612 amazon-ssm-agent[1980]: 2025-10-28 04:40:32.9911 INFO [EC2Identity] Generating registration keypair Oct 28 04:40:33.452612 amazon-ssm-agent[1980]: 2025-10-28 04:40:33.3505 INFO [EC2Identity] Checking write access before registering Oct 28 04:40:33.452786 amazon-ssm-agent[1980]: 2025-10-28 04:40:33.3515 INFO [EC2Identity] Registering EC2 instance with Systems Manager Oct 28 04:40:33.452913 amazon-ssm-agent[1980]: 2025-10-28 04:40:33.4080 INFO [EC2Identity] EC2 registration was successful. Oct 28 04:40:33.453035 amazon-ssm-agent[1980]: 2025-10-28 04:40:33.4080 INFO [amazon-ssm-agent] Registration attempted. Resuming core agent startup. Oct 28 04:40:33.453250 amazon-ssm-agent[1980]: 2025-10-28 04:40:33.4098 INFO [CredentialRefresher] credentialRefresher has started Oct 28 04:40:33.453250 amazon-ssm-agent[1980]: 2025-10-28 04:40:33.4111 INFO [CredentialRefresher] Starting credentials refresher loop Oct 28 04:40:33.453427 amazon-ssm-agent[1980]: 2025-10-28 04:40:33.4514 INFO EC2RoleProvider Successfully connected with instance profile role credentials Oct 28 04:40:33.455398 amazon-ssm-agent[1980]: 2025-10-28 04:40:33.4518 INFO [CredentialRefresher] Credentials ready Oct 28 04:40:33.485970 amazon-ssm-agent[1980]: 2025-10-28 04:40:33.4552 INFO [CredentialRefresher] Next credential rotation will be in 29.9999369109 minutes Oct 28 04:40:33.589197 systemd-coredump[1933]: Process 1835 (ntpd) of user 0 dumped core. Stack trace of thread 1835: #0 0x0000aaaaca8b0b5c n/a (n/a + 0x0) #1 0x0000aaaaca8b0b54 n/a (n/a + 0x0) #2 0x0000aaaaca85fe60 n/a (n/a + 0x0) #3 0x0000aaaaca860240 n/a (n/a + 0x0) #4 0x0000aaaaca85be14 n/a (n/a + 0x0) #5 0x0000aaaaca85d3ec n/a (n/a + 0x0) #6 0x0000aaaaca865a38 n/a (n/a + 0x0) #7 0x0000aaaaca85738c n/a (n/a + 0x0) #8 0x0000ffff95f72034 n/a (n/a + 0x0) #9 0x0000ffff95f72118 n/a (n/a + 0x0) #10 0x0000aaaaca8573f0 n/a (n/a + 0x0) ELF object binary architecture: AARCH64 Oct 28 04:40:33.592663 systemd[1]: ntpd.service: Main process exited, code=dumped, status=11/SEGV Oct 28 04:40:33.593003 systemd[1]: ntpd.service: Failed with result 'core-dump'. Oct 28 04:40:33.605775 systemd[1]: systemd-coredump@0-1910-0.service: Deactivated successfully. Oct 28 04:40:33.621350 polkitd[2099]: Started polkitd version 126 Oct 28 04:40:33.633954 polkitd[2099]: Loading rules from directory /etc/polkit-1/rules.d Oct 28 04:40:33.634889 polkitd[2099]: Loading rules from directory /run/polkit-1/rules.d Oct 28 04:40:33.635101 polkitd[2099]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Oct 28 04:40:33.635999 polkitd[2099]: Loading rules from directory /usr/local/share/polkit-1/rules.d Oct 28 04:40:33.636274 polkitd[2099]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Oct 28 04:40:33.636549 polkitd[2099]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 28 04:40:33.638687 polkitd[2099]: Finished loading, compiling and executing 2 rules Oct 28 04:40:33.639629 systemd[1]: Started polkit.service - Authorization Manager. Oct 28 04:40:33.645495 dbus-daemon[1817]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 28 04:40:33.646289 polkitd[2099]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 28 04:40:33.667182 systemd-hostnamed[1882]: Hostname set to (static) Oct 28 04:40:33.943930 systemd[1]: ntpd.service: Scheduled restart job, restart counter is at 1. Oct 28 04:40:33.950293 systemd[1]: Started ntpd.service - Network Time Service. Oct 28 04:40:33.985282 ntpd[2115]: ntpd 4.2.8p18@1.4062-o Tue Oct 28 02:53:21 UTC 2025 (1): Starting Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: ntpd 4.2.8p18@1.4062-o Tue Oct 28 02:53:21 UTC 2025 (1): Starting Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: ---------------------------------------------------- Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: ntp-4 is maintained by Network Time Foundation, Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: corporation. Support and training for ntp-4 are Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: available at https://www.nwtime.org/support Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: ---------------------------------------------------- Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: proto: precision = 0.096 usec (-23) Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: basedate set to 2025-10-16 Oct 28 04:40:33.988178 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: gps base set to 2025-10-19 (week 2389) Oct 28 04:40:33.986031 ntpd[2115]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Oct 28 04:40:33.986055 ntpd[2115]: ---------------------------------------------------- Oct 28 04:40:33.986072 ntpd[2115]: ntp-4 is maintained by Network Time Foundation, Oct 28 04:40:33.986091 ntpd[2115]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Oct 28 04:40:33.986198 ntpd[2115]: corporation. Support and training for ntp-4 are Oct 28 04:40:33.986223 ntpd[2115]: available at https://www.nwtime.org/support Oct 28 04:40:33.986247 ntpd[2115]: ---------------------------------------------------- Oct 28 04:40:33.987539 ntpd[2115]: proto: precision = 0.096 usec (-23) Oct 28 04:40:33.987936 ntpd[2115]: basedate set to 2025-10-16 Oct 28 04:40:33.987964 ntpd[2115]: gps base set to 2025-10-19 (week 2389) Oct 28 04:40:33.990265 ntpd[2115]: Listen and drop on 0 v6wildcard [::]:123 Oct 28 04:40:33.991370 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: Listen and drop on 0 v6wildcard [::]:123 Oct 28 04:40:33.991370 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 28 04:40:33.991370 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: Listen normally on 2 lo 127.0.0.1:123 Oct 28 04:40:33.991370 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: Listen normally on 3 eth0 172.31.24.152:123 Oct 28 04:40:33.991370 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: Listen normally on 4 lo [::1]:123 Oct 28 04:40:33.991370 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: Listen normally on 5 eth0 [fe80::4d0:44ff:fe56:e375%2]:123 Oct 28 04:40:33.991370 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: Listening on routing socket on fd #22 for interface updates Oct 28 04:40:33.990340 ntpd[2115]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 28 04:40:33.990669 ntpd[2115]: Listen normally on 2 lo 127.0.0.1:123 Oct 28 04:40:33.990723 ntpd[2115]: Listen normally on 3 eth0 172.31.24.152:123 Oct 28 04:40:33.990773 ntpd[2115]: Listen normally on 4 lo [::1]:123 Oct 28 04:40:33.990819 ntpd[2115]: Listen normally on 5 eth0 [fe80::4d0:44ff:fe56:e375%2]:123 Oct 28 04:40:33.990863 ntpd[2115]: Listening on routing socket on fd #22 for interface updates Oct 28 04:40:33.999872 ntpd[2115]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 28 04:40:34.002149 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 28 04:40:34.002149 ntpd[2115]: 28 Oct 04:40:33 ntpd[2115]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 28 04:40:34.000249 ntpd[2115]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 28 04:40:34.105808 sshd_keygen[1870]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 28 04:40:34.153294 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 28 04:40:34.160930 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 28 04:40:34.169627 systemd[1]: Started sshd@0-172.31.24.152:22-147.75.109.163:42856.service - OpenSSH per-connection server daemon (147.75.109.163:42856). Oct 28 04:40:34.190213 systemd[1]: issuegen.service: Deactivated successfully. Oct 28 04:40:34.192411 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 28 04:40:34.201465 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 28 04:40:34.240766 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 28 04:40:34.246982 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 28 04:40:34.260557 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 28 04:40:34.271012 systemd[1]: Reached target getty.target - Login Prompts. Oct 28 04:40:34.277020 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 28 04:40:34.281242 systemd[1]: Startup finished in 2.552s (kernel) + 6.432s (initrd) + 8.011s (userspace) = 16.996s. Oct 28 04:40:34.414602 sshd[2127]: Accepted publickey for core from 147.75.109.163 port 42856 ssh2: RSA SHA256:n8I+mfZFO+vpjscdCCq4ICa9JhGSHCmaRNUJmvrCQJg Oct 28 04:40:34.417800 sshd-session[2127]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:34.431901 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 28 04:40:34.436592 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 28 04:40:34.454218 systemd-logind[1839]: New session 1 of user core. Oct 28 04:40:34.474817 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 28 04:40:34.486532 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 28 04:40:34.498715 amazon-ssm-agent[1980]: 2025-10-28 04:40:34.4902 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Oct 28 04:40:34.509634 (systemd)[2143]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:40:34.514336 systemd-logind[1839]: New session c1 of user core. Oct 28 04:40:34.598934 amazon-ssm-agent[1980]: 2025-10-28 04:40:34.5291 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2144) started Oct 28 04:40:34.699324 amazon-ssm-agent[1980]: 2025-10-28 04:40:34.5291 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Oct 28 04:40:34.821995 systemd[2143]: Queued start job for default target default.target. Oct 28 04:40:34.833314 systemd[2143]: Created slice app.slice - User Application Slice. Oct 28 04:40:34.833386 systemd[2143]: Reached target paths.target - Paths. Oct 28 04:40:34.833489 systemd[2143]: Reached target timers.target - Timers. Oct 28 04:40:34.836597 systemd[2143]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 28 04:40:34.872950 systemd[2143]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 28 04:40:34.873329 systemd[2143]: Reached target sockets.target - Sockets. Oct 28 04:40:34.873436 systemd[2143]: Reached target basic.target - Basic System. Oct 28 04:40:34.874539 systemd[2143]: Reached target default.target - Main User Target. Oct 28 04:40:34.874642 systemd[2143]: Startup finished in 347ms. Oct 28 04:40:34.874978 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 28 04:40:34.887477 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 28 04:40:34.978431 systemd[1]: Started sshd@1-172.31.24.152:22-147.75.109.163:42868.service - OpenSSH per-connection server daemon (147.75.109.163:42868). Oct 28 04:40:35.164724 sshd[2168]: Accepted publickey for core from 147.75.109.163 port 42868 ssh2: RSA SHA256:n8I+mfZFO+vpjscdCCq4ICa9JhGSHCmaRNUJmvrCQJg Oct 28 04:40:35.167444 sshd-session[2168]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:35.179219 systemd-logind[1839]: New session 2 of user core. Oct 28 04:40:35.189461 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 28 04:40:35.253611 sshd[2171]: Connection closed by 147.75.109.163 port 42868 Oct 28 04:40:35.254537 sshd-session[2168]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:35.263710 systemd[1]: sshd@1-172.31.24.152:22-147.75.109.163:42868.service: Deactivated successfully. Oct 28 04:40:35.267911 systemd[1]: session-2.scope: Deactivated successfully. Oct 28 04:40:35.272074 systemd-logind[1839]: Session 2 logged out. Waiting for processes to exit. Oct 28 04:40:35.287851 systemd-logind[1839]: Removed session 2. Oct 28 04:40:35.288519 systemd[1]: Started sshd@2-172.31.24.152:22-147.75.109.163:42880.service - OpenSSH per-connection server daemon (147.75.109.163:42880). Oct 28 04:40:35.476016 sshd[2177]: Accepted publickey for core from 147.75.109.163 port 42880 ssh2: RSA SHA256:n8I+mfZFO+vpjscdCCq4ICa9JhGSHCmaRNUJmvrCQJg Oct 28 04:40:35.478899 sshd-session[2177]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:35.489225 systemd-logind[1839]: New session 3 of user core. Oct 28 04:40:35.496476 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 28 04:40:35.553784 sshd[2180]: Connection closed by 147.75.109.163 port 42880 Oct 28 04:40:35.555215 sshd-session[2177]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:35.563897 systemd[1]: sshd@2-172.31.24.152:22-147.75.109.163:42880.service: Deactivated successfully. Oct 28 04:40:35.568248 systemd[1]: session-3.scope: Deactivated successfully. Oct 28 04:40:35.572581 systemd-logind[1839]: Session 3 logged out. Waiting for processes to exit. Oct 28 04:40:35.575072 systemd-logind[1839]: Removed session 3. Oct 28 04:40:35.589962 systemd[1]: Started sshd@3-172.31.24.152:22-147.75.109.163:42894.service - OpenSSH per-connection server daemon (147.75.109.163:42894). Oct 28 04:40:35.780845 sshd[2186]: Accepted publickey for core from 147.75.109.163 port 42894 ssh2: RSA SHA256:n8I+mfZFO+vpjscdCCq4ICa9JhGSHCmaRNUJmvrCQJg Oct 28 04:40:35.783174 sshd-session[2186]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:35.794246 systemd-logind[1839]: New session 4 of user core. Oct 28 04:40:35.801440 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 28 04:40:35.870164 sshd[2189]: Connection closed by 147.75.109.163 port 42894 Oct 28 04:40:35.870405 sshd-session[2186]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:35.878955 systemd-logind[1839]: Session 4 logged out. Waiting for processes to exit. Oct 28 04:40:35.879238 systemd[1]: sshd@3-172.31.24.152:22-147.75.109.163:42894.service: Deactivated successfully. Oct 28 04:40:35.884258 systemd[1]: session-4.scope: Deactivated successfully. Oct 28 04:40:35.904658 systemd-logind[1839]: Removed session 4. Oct 28 04:40:35.905590 systemd[1]: Started sshd@4-172.31.24.152:22-147.75.109.163:42904.service - OpenSSH per-connection server daemon (147.75.109.163:42904). Oct 28 04:40:36.084546 sshd[2195]: Accepted publickey for core from 147.75.109.163 port 42904 ssh2: RSA SHA256:n8I+mfZFO+vpjscdCCq4ICa9JhGSHCmaRNUJmvrCQJg Oct 28 04:40:36.087625 sshd-session[2195]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:36.098242 systemd-logind[1839]: New session 5 of user core. Oct 28 04:40:36.105466 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 28 04:40:36.170602 sudo[2199]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 28 04:40:36.171958 sudo[2199]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 28 04:40:36.192354 sudo[2199]: pam_unix(sudo:session): session closed for user root Oct 28 04:40:36.218159 sshd[2198]: Connection closed by 147.75.109.163 port 42904 Oct 28 04:40:36.216839 sshd-session[2195]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:36.224641 systemd[1]: sshd@4-172.31.24.152:22-147.75.109.163:42904.service: Deactivated successfully. Oct 28 04:40:36.228582 systemd[1]: session-5.scope: Deactivated successfully. Oct 28 04:40:36.234436 systemd-logind[1839]: Session 5 logged out. Waiting for processes to exit. Oct 28 04:40:36.237239 systemd-logind[1839]: Removed session 5. Oct 28 04:40:36.252864 systemd[1]: Started sshd@5-172.31.24.152:22-147.75.109.163:42912.service - OpenSSH per-connection server daemon (147.75.109.163:42912). Oct 28 04:40:36.435888 sshd[2205]: Accepted publickey for core from 147.75.109.163 port 42912 ssh2: RSA SHA256:n8I+mfZFO+vpjscdCCq4ICa9JhGSHCmaRNUJmvrCQJg Oct 28 04:40:36.438486 sshd-session[2205]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:36.448088 systemd-logind[1839]: New session 6 of user core. Oct 28 04:40:36.458380 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 28 04:40:36.502076 sudo[2210]: 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 Oct 28 04:40:36.503219 sudo[2210]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 28 04:40:36.512898 sudo[2210]: pam_unix(sudo:session): session closed for user root Oct 28 04:40:36.524971 sudo[2209]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 28 04:40:36.525588 sudo[2209]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 28 04:40:36.542686 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 28 04:40:36.607440 augenrules[2232]: No rules Oct 28 04:40:36.610091 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 04:40:36.610675 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 28 04:40:36.613444 sudo[2209]: pam_unix(sudo:session): session closed for user root Oct 28 04:40:36.637191 sshd[2208]: Connection closed by 147.75.109.163 port 42912 Oct 28 04:40:36.637949 sshd-session[2205]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:36.645102 systemd[1]: sshd@5-172.31.24.152:22-147.75.109.163:42912.service: Deactivated successfully. Oct 28 04:40:36.649856 systemd[1]: session-6.scope: Deactivated successfully. Oct 28 04:40:36.652959 systemd-logind[1839]: Session 6 logged out. Waiting for processes to exit. Oct 28 04:40:36.655362 systemd-logind[1839]: Removed session 6. Oct 28 04:40:36.674323 systemd[1]: Started sshd@6-172.31.24.152:22-147.75.109.163:42924.service - OpenSSH per-connection server daemon (147.75.109.163:42924). Oct 28 04:40:36.853925 sshd[2241]: Accepted publickey for core from 147.75.109.163 port 42924 ssh2: RSA SHA256:n8I+mfZFO+vpjscdCCq4ICa9JhGSHCmaRNUJmvrCQJg Oct 28 04:40:36.856201 sshd-session[2241]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:36.864013 systemd-logind[1839]: New session 7 of user core. Oct 28 04:40:36.871347 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 28 04:40:36.936249 sshd[2244]: Connection closed by 147.75.109.163 port 42924 Oct 28 04:40:36.937031 sshd-session[2241]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:36.944030 systemd[1]: sshd@6-172.31.24.152:22-147.75.109.163:42924.service: Deactivated successfully. Oct 28 04:40:36.948391 systemd[1]: session-7.scope: Deactivated successfully. Oct 28 04:40:36.950303 systemd-logind[1839]: Session 7 logged out. Waiting for processes to exit. Oct 28 04:40:36.953626 systemd-logind[1839]: Removed session 7. Oct 28 04:40:36.973558 systemd[1]: Started sshd@7-172.31.24.152:22-147.75.109.163:42938.service - OpenSSH per-connection server daemon (147.75.109.163:42938). Oct 28 04:40:37.161887 sshd[2250]: Accepted publickey for core from 147.75.109.163 port 42938 ssh2: RSA SHA256:n8I+mfZFO+vpjscdCCq4ICa9JhGSHCmaRNUJmvrCQJg Oct 28 04:40:37.164222 sshd-session[2250]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:37.172027 systemd-logind[1839]: New session 8 of user core. Oct 28 04:40:37.191346 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 28 04:40:37.250191 sshd[2253]: Connection closed by 147.75.109.163 port 42938 Oct 28 04:40:37.251016 sshd-session[2250]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:37.258767 systemd[1]: sshd@7-172.31.24.152:22-147.75.109.163:42938.service: Deactivated successfully. Oct 28 04:40:37.264666 systemd[1]: session-8.scope: Deactivated successfully. Oct 28 04:40:37.267337 systemd-logind[1839]: Session 8 logged out. Waiting for processes to exit. Oct 28 04:40:37.269744 systemd-logind[1839]: Removed session 8.