May 13 23:41:32.165666 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] May 13 23:41:32.165711 kernel: Linux version 6.6.89-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT Tue May 13 22:16:18 -00 2025 May 13 23:41:32.165736 kernel: KASLR disabled due to lack of seed May 13 23:41:32.165752 kernel: efi: EFI v2.7 by EDK II May 13 23:41:32.165767 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7a733a98 MEMRESERVE=0x78557598 May 13 23:41:32.165782 kernel: secureboot: Secure boot disabled May 13 23:41:32.165799 kernel: ACPI: Early table checksum verification disabled May 13 23:41:32.165813 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) May 13 23:41:32.165829 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) May 13 23:41:32.165844 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) May 13 23:41:32.165864 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) May 13 23:41:32.165879 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) May 13 23:41:32.165894 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) May 13 23:41:32.165909 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) May 13 23:41:32.165927 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) May 13 23:41:32.165947 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) May 13 23:41:32.165964 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) May 13 23:41:32.165980 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) May 13 23:41:32.165996 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 May 13 23:41:32.166012 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') May 13 23:41:32.166027 kernel: printk: bootconsole [uart0] enabled May 13 23:41:32.166043 kernel: NUMA: Failed to initialise from firmware May 13 23:41:32.166059 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] May 13 23:41:32.166074 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] May 13 23:41:32.166090 kernel: Zone ranges: May 13 23:41:32.166123 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] May 13 23:41:32.166150 kernel: DMA32 empty May 13 23:41:32.166167 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] May 13 23:41:32.166183 kernel: Movable zone start for each node May 13 23:41:32.166198 kernel: Early memory node ranges May 13 23:41:32.166214 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] May 13 23:41:32.166230 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] May 13 23:41:32.166245 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] May 13 23:41:32.166261 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] May 13 23:41:32.166277 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] May 13 23:41:32.166292 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] May 13 23:41:32.166308 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] May 13 23:41:32.166323 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] May 13 23:41:32.166344 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] May 13 23:41:32.166360 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges May 13 23:41:32.166383 kernel: psci: probing for conduit method from ACPI. May 13 23:41:32.166400 kernel: psci: PSCIv1.0 detected in firmware. May 13 23:41:32.166417 kernel: psci: Using standard PSCI v0.2 function IDs May 13 23:41:32.166437 kernel: psci: Trusted OS migration not required May 13 23:41:32.166455 kernel: psci: SMC Calling Convention v1.1 May 13 23:41:32.166471 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 May 13 23:41:32.166487 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 May 13 23:41:32.166504 kernel: pcpu-alloc: [0] 0 [0] 1 May 13 23:41:32.166521 kernel: Detected PIPT I-cache on CPU0 May 13 23:41:32.166537 kernel: CPU features: detected: GIC system register CPU interface May 13 23:41:32.166554 kernel: CPU features: detected: Spectre-v2 May 13 23:41:32.166570 kernel: CPU features: detected: Spectre-v3a May 13 23:41:32.166587 kernel: CPU features: detected: Spectre-BHB May 13 23:41:32.166603 kernel: CPU features: detected: ARM erratum 1742098 May 13 23:41:32.166620 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 May 13 23:41:32.166641 kernel: alternatives: applying boot alternatives May 13 23:41:32.166660 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=3174b2682629aa8ad4069807ed6fd62c10f62266ee1e150a1104f2a2fb6489b5 May 13 23:41:32.166678 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 13 23:41:32.166694 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 13 23:41:32.166711 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 13 23:41:32.166728 kernel: Fallback order for Node 0: 0 May 13 23:41:32.166744 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 May 13 23:41:32.166761 kernel: Policy zone: Normal May 13 23:41:32.166777 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 13 23:41:32.166794 kernel: software IO TLB: area num 2. May 13 23:41:32.166815 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) May 13 23:41:32.166833 kernel: Memory: 3821048K/4030464K available (10368K kernel code, 2186K rwdata, 8100K rodata, 38464K init, 897K bss, 209416K reserved, 0K cma-reserved) May 13 23:41:32.166849 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 May 13 23:41:32.166866 kernel: rcu: Preemptible hierarchical RCU implementation. May 13 23:41:32.166883 kernel: rcu: RCU event tracing is enabled. May 13 23:41:32.166900 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. May 13 23:41:32.166918 kernel: Trampoline variant of Tasks RCU enabled. May 13 23:41:32.166935 kernel: Tracing variant of Tasks RCU enabled. May 13 23:41:32.166951 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 13 23:41:32.166968 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 May 13 23:41:32.166985 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 May 13 23:41:32.167006 kernel: GICv3: 96 SPIs implemented May 13 23:41:32.167022 kernel: GICv3: 0 Extended SPIs implemented May 13 23:41:32.167039 kernel: Root IRQ handler: gic_handle_irq May 13 23:41:32.167055 kernel: GICv3: GICv3 features: 16 PPIs May 13 23:41:32.167072 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 May 13 23:41:32.167088 kernel: ITS [mem 0x10080000-0x1009ffff] May 13 23:41:32.169133 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) May 13 23:41:32.169172 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) May 13 23:41:32.169190 kernel: GICv3: using LPI property table @0x00000004000d0000 May 13 23:41:32.169207 kernel: ITS: Using hypervisor restricted LPI range [128] May 13 23:41:32.169224 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 May 13 23:41:32.169241 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 13 23:41:32.169267 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). May 13 23:41:32.169284 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns May 13 23:41:32.169300 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns May 13 23:41:32.169317 kernel: Console: colour dummy device 80x25 May 13 23:41:32.169335 kernel: printk: console [tty1] enabled May 13 23:41:32.169352 kernel: ACPI: Core revision 20230628 May 13 23:41:32.169369 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) May 13 23:41:32.169386 kernel: pid_max: default: 32768 minimum: 301 May 13 23:41:32.169403 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity May 13 23:41:32.169420 kernel: landlock: Up and running. May 13 23:41:32.169442 kernel: SELinux: Initializing. May 13 23:41:32.169460 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 13 23:41:32.169477 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 13 23:41:32.169515 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 13 23:41:32.169533 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 13 23:41:32.169550 kernel: rcu: Hierarchical SRCU implementation. May 13 23:41:32.169568 kernel: rcu: Max phase no-delay instances is 400. May 13 23:41:32.169585 kernel: Platform MSI: ITS@0x10080000 domain created May 13 23:41:32.169607 kernel: PCI/MSI: ITS@0x10080000 domain created May 13 23:41:32.169625 kernel: Remapping and enabling EFI services. May 13 23:41:32.169642 kernel: smp: Bringing up secondary CPUs ... May 13 23:41:32.169659 kernel: Detected PIPT I-cache on CPU1 May 13 23:41:32.169676 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 May 13 23:41:32.169693 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 May 13 23:41:32.169710 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] May 13 23:41:32.169727 kernel: smp: Brought up 1 node, 2 CPUs May 13 23:41:32.169744 kernel: SMP: Total of 2 processors activated. May 13 23:41:32.169761 kernel: CPU features: detected: 32-bit EL0 Support May 13 23:41:32.169782 kernel: CPU features: detected: 32-bit EL1 Support May 13 23:41:32.169800 kernel: CPU features: detected: CRC32 instructions May 13 23:41:32.169828 kernel: CPU: All CPU(s) started at EL1 May 13 23:41:32.169850 kernel: alternatives: applying system-wide alternatives May 13 23:41:32.169868 kernel: devtmpfs: initialized May 13 23:41:32.169885 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 13 23:41:32.169903 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) May 13 23:41:32.169921 kernel: pinctrl core: initialized pinctrl subsystem May 13 23:41:32.169938 kernel: SMBIOS 3.0.0 present. May 13 23:41:32.169961 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 May 13 23:41:32.169979 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 13 23:41:32.169997 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations May 13 23:41:32.170015 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations May 13 23:41:32.170033 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations May 13 23:41:32.170050 kernel: audit: initializing netlink subsys (disabled) May 13 23:41:32.170068 kernel: audit: type=2000 audit(0.218:1): state=initialized audit_enabled=0 res=1 May 13 23:41:32.170091 kernel: thermal_sys: Registered thermal governor 'step_wise' May 13 23:41:32.170137 kernel: cpuidle: using governor menu May 13 23:41:32.170159 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. May 13 23:41:32.170178 kernel: ASID allocator initialised with 65536 entries May 13 23:41:32.170195 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 13 23:41:32.170213 kernel: Serial: AMBA PL011 UART driver May 13 23:41:32.170232 kernel: Modules: 17712 pages in range for non-PLT usage May 13 23:41:32.170249 kernel: Modules: 509232 pages in range for PLT usage May 13 23:41:32.170267 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 13 23:41:32.170291 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page May 13 23:41:32.170310 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages May 13 23:41:32.170327 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page May 13 23:41:32.170345 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 13 23:41:32.170363 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page May 13 23:41:32.170381 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages May 13 23:41:32.170398 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page May 13 23:41:32.170416 kernel: ACPI: Added _OSI(Module Device) May 13 23:41:32.170434 kernel: ACPI: Added _OSI(Processor Device) May 13 23:41:32.170456 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 13 23:41:32.170474 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 13 23:41:32.170492 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 13 23:41:32.170509 kernel: ACPI: Interpreter enabled May 13 23:41:32.170527 kernel: ACPI: Using GIC for interrupt routing May 13 23:41:32.170545 kernel: ACPI: MCFG table detected, 1 entries May 13 23:41:32.170562 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) May 13 23:41:32.170870 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 13 23:41:32.171076 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] May 13 23:41:32.172261 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] May 13 23:41:32.172467 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 May 13 23:41:32.172666 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] May 13 23:41:32.172691 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] May 13 23:41:32.172709 kernel: acpiphp: Slot [1] registered May 13 23:41:32.172728 kernel: acpiphp: Slot [2] registered May 13 23:41:32.172746 kernel: acpiphp: Slot [3] registered May 13 23:41:32.172771 kernel: acpiphp: Slot [4] registered May 13 23:41:32.172789 kernel: acpiphp: Slot [5] registered May 13 23:41:32.172806 kernel: acpiphp: Slot [6] registered May 13 23:41:32.172824 kernel: acpiphp: Slot [7] registered May 13 23:41:32.172842 kernel: acpiphp: Slot [8] registered May 13 23:41:32.172859 kernel: acpiphp: Slot [9] registered May 13 23:41:32.172877 kernel: acpiphp: Slot [10] registered May 13 23:41:32.172894 kernel: acpiphp: Slot [11] registered May 13 23:41:32.172912 kernel: acpiphp: Slot [12] registered May 13 23:41:32.172929 kernel: acpiphp: Slot [13] registered May 13 23:41:32.172952 kernel: acpiphp: Slot [14] registered May 13 23:41:32.172969 kernel: acpiphp: Slot [15] registered May 13 23:41:32.172987 kernel: acpiphp: Slot [16] registered May 13 23:41:32.173004 kernel: acpiphp: Slot [17] registered May 13 23:41:32.173022 kernel: acpiphp: Slot [18] registered May 13 23:41:32.173040 kernel: acpiphp: Slot [19] registered May 13 23:41:32.173057 kernel: acpiphp: Slot [20] registered May 13 23:41:32.173074 kernel: acpiphp: Slot [21] registered May 13 23:41:32.173092 kernel: acpiphp: Slot [22] registered May 13 23:41:32.173143 kernel: acpiphp: Slot [23] registered May 13 23:41:32.173164 kernel: acpiphp: Slot [24] registered May 13 23:41:32.173181 kernel: acpiphp: Slot [25] registered May 13 23:41:32.173199 kernel: acpiphp: Slot [26] registered May 13 23:41:32.173217 kernel: acpiphp: Slot [27] registered May 13 23:41:32.173234 kernel: acpiphp: Slot [28] registered May 13 23:41:32.173252 kernel: acpiphp: Slot [29] registered May 13 23:41:32.173270 kernel: acpiphp: Slot [30] registered May 13 23:41:32.173288 kernel: acpiphp: Slot [31] registered May 13 23:41:32.173305 kernel: PCI host bridge to bus 0000:00 May 13 23:41:32.173545 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] May 13 23:41:32.173735 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] May 13 23:41:32.173918 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] May 13 23:41:32.174100 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] May 13 23:41:32.175532 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 May 13 23:41:32.175775 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 May 13 23:41:32.175985 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] May 13 23:41:32.176228 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 May 13 23:41:32.176433 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] May 13 23:41:32.176633 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold May 13 23:41:32.176851 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 May 13 23:41:32.177060 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] May 13 23:41:32.179383 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] May 13 23:41:32.179710 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] May 13 23:41:32.179938 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold May 13 23:41:32.182542 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] May 13 23:41:32.182784 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] May 13 23:41:32.183004 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] May 13 23:41:32.183273 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] May 13 23:41:32.183486 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] May 13 23:41:32.183684 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] May 13 23:41:32.183863 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] May 13 23:41:32.184041 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] May 13 23:41:32.184066 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 May 13 23:41:32.184085 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 May 13 23:41:32.186135 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 May 13 23:41:32.186190 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 May 13 23:41:32.186211 kernel: iommu: Default domain type: Translated May 13 23:41:32.186250 kernel: iommu: DMA domain TLB invalidation policy: strict mode May 13 23:41:32.186269 kernel: efivars: Registered efivars operations May 13 23:41:32.186288 kernel: vgaarb: loaded May 13 23:41:32.186306 kernel: clocksource: Switched to clocksource arch_sys_counter May 13 23:41:32.186324 kernel: VFS: Disk quotas dquot_6.6.0 May 13 23:41:32.186342 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 13 23:41:32.186360 kernel: pnp: PnP ACPI init May 13 23:41:32.186632 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved May 13 23:41:32.186664 kernel: pnp: PnP ACPI: found 1 devices May 13 23:41:32.186683 kernel: NET: Registered PF_INET protocol family May 13 23:41:32.186702 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 13 23:41:32.186720 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 13 23:41:32.186738 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 13 23:41:32.186756 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 13 23:41:32.186774 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 13 23:41:32.186792 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 13 23:41:32.186810 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 13 23:41:32.186832 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 13 23:41:32.186850 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 13 23:41:32.186868 kernel: PCI: CLS 0 bytes, default 64 May 13 23:41:32.186886 kernel: kvm [1]: HYP mode not available May 13 23:41:32.186903 kernel: Initialise system trusted keyrings May 13 23:41:32.186921 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 13 23:41:32.186939 kernel: Key type asymmetric registered May 13 23:41:32.186957 kernel: Asymmetric key parser 'x509' registered May 13 23:41:32.186974 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 13 23:41:32.186996 kernel: io scheduler mq-deadline registered May 13 23:41:32.187014 kernel: io scheduler kyber registered May 13 23:41:32.187032 kernel: io scheduler bfq registered May 13 23:41:32.187304 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered May 13 23:41:32.187332 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 May 13 23:41:32.187351 kernel: ACPI: button: Power Button [PWRB] May 13 23:41:32.187369 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 May 13 23:41:32.187387 kernel: ACPI: button: Sleep Button [SLPB] May 13 23:41:32.187412 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 13 23:41:32.187431 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 May 13 23:41:32.187638 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) May 13 23:41:32.187664 kernel: printk: console [ttyS0] disabled May 13 23:41:32.187682 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A May 13 23:41:32.187700 kernel: printk: console [ttyS0] enabled May 13 23:41:32.187718 kernel: printk: bootconsole [uart0] disabled May 13 23:41:32.187736 kernel: thunder_xcv, ver 1.0 May 13 23:41:32.187754 kernel: thunder_bgx, ver 1.0 May 13 23:41:32.187773 kernel: nicpf, ver 1.0 May 13 23:41:32.187796 kernel: nicvf, ver 1.0 May 13 23:41:32.188012 kernel: rtc-efi rtc-efi.0: registered as rtc0 May 13 23:41:32.190315 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-05-13T23:41:31 UTC (1747179691) May 13 23:41:32.190359 kernel: hid: raw HID events driver (C) Jiri Kosina May 13 23:41:32.190380 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available May 13 23:41:32.190398 kernel: watchdog: Delayed init of the lockup detector failed: -19 May 13 23:41:32.190417 kernel: watchdog: Hard watchdog permanently disabled May 13 23:41:32.190445 kernel: NET: Registered PF_INET6 protocol family May 13 23:41:32.190464 kernel: Segment Routing with IPv6 May 13 23:41:32.190482 kernel: In-situ OAM (IOAM) with IPv6 May 13 23:41:32.190500 kernel: NET: Registered PF_PACKET protocol family May 13 23:41:32.190518 kernel: Key type dns_resolver registered May 13 23:41:32.190536 kernel: registered taskstats version 1 May 13 23:41:32.190554 kernel: Loading compiled-in X.509 certificates May 13 23:41:32.190572 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.89-flatcar: 568a15bbab977599d8f910f319ba50c03c8a57bd' May 13 23:41:32.190589 kernel: Key type .fscrypt registered May 13 23:41:32.190607 kernel: Key type fscrypt-provisioning registered May 13 23:41:32.190629 kernel: ima: No TPM chip found, activating TPM-bypass! May 13 23:41:32.190647 kernel: ima: Allocated hash algorithm: sha1 May 13 23:41:32.190665 kernel: ima: No architecture policies found May 13 23:41:32.190682 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) May 13 23:41:32.190700 kernel: clk: Disabling unused clocks May 13 23:41:32.190718 kernel: Freeing unused kernel memory: 38464K May 13 23:41:32.190735 kernel: Run /init as init process May 13 23:41:32.190753 kernel: with arguments: May 13 23:41:32.190770 kernel: /init May 13 23:41:32.190792 kernel: with environment: May 13 23:41:32.190810 kernel: HOME=/ May 13 23:41:32.190827 kernel: TERM=linux May 13 23:41:32.190845 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 13 23:41:32.190864 systemd[1]: Successfully made /usr/ read-only. May 13 23:41:32.190888 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 13 23:41:32.190909 systemd[1]: Detected virtualization amazon. May 13 23:41:32.190933 systemd[1]: Detected architecture arm64. May 13 23:41:32.190952 systemd[1]: Running in initrd. May 13 23:41:32.190971 systemd[1]: No hostname configured, using default hostname. May 13 23:41:32.190991 systemd[1]: Hostname set to . May 13 23:41:32.191010 systemd[1]: Initializing machine ID from VM UUID. May 13 23:41:32.191029 systemd[1]: Queued start job for default target initrd.target. May 13 23:41:32.191048 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 13 23:41:32.191068 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 13 23:41:32.191088 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 13 23:41:32.191173 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 13 23:41:32.191197 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 13 23:41:32.191219 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 13 23:41:32.191241 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 13 23:41:32.191261 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 13 23:41:32.191281 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 13 23:41:32.191307 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 13 23:41:32.191326 systemd[1]: Reached target paths.target - Path Units. May 13 23:41:32.191346 systemd[1]: Reached target slices.target - Slice Units. May 13 23:41:32.191365 systemd[1]: Reached target swap.target - Swaps. May 13 23:41:32.191384 systemd[1]: Reached target timers.target - Timer Units. May 13 23:41:32.191403 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 13 23:41:32.191423 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 13 23:41:32.191442 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 13 23:41:32.191462 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 13 23:41:32.191486 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 13 23:41:32.191505 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 13 23:41:32.191525 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 13 23:41:32.191544 systemd[1]: Reached target sockets.target - Socket Units. May 13 23:41:32.191564 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 13 23:41:32.191583 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 13 23:41:32.191603 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 13 23:41:32.191622 systemd[1]: Starting systemd-fsck-usr.service... May 13 23:41:32.191646 systemd[1]: Starting systemd-journald.service - Journal Service... May 13 23:41:32.191666 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 13 23:41:32.191685 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 13 23:41:32.191705 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 13 23:41:32.191724 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 13 23:41:32.191744 systemd[1]: Finished systemd-fsck-usr.service. May 13 23:41:32.191769 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 13 23:41:32.191825 systemd-journald[250]: Collecting audit messages is disabled. May 13 23:41:32.191868 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 13 23:41:32.191893 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 13 23:41:32.191912 kernel: Bridge firewalling registered May 13 23:41:32.191931 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 13 23:41:32.191951 systemd-journald[250]: Journal started May 13 23:41:32.191986 systemd-journald[250]: Runtime Journal (/run/log/journal/ec212c097a81cc5f002a10712061db2e) is 8M, max 75.3M, 67.3M free. May 13 23:41:32.149240 systemd-modules-load[252]: Inserted module 'overlay' May 13 23:41:32.192446 systemd-modules-load[252]: Inserted module 'br_netfilter' May 13 23:41:32.202149 systemd[1]: Started systemd-journald.service - Journal Service. May 13 23:41:32.204941 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 13 23:41:32.211891 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 13 23:41:32.222322 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 13 23:41:32.224196 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 13 23:41:32.229464 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 13 23:41:32.270484 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 13 23:41:32.279594 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 13 23:41:32.288175 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 13 23:41:32.296358 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 13 23:41:32.306701 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 13 23:41:32.315311 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 13 23:41:32.345930 dracut-cmdline[290]: dracut-dracut-053 May 13 23:41:32.356139 dracut-cmdline[290]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=3174b2682629aa8ad4069807ed6fd62c10f62266ee1e150a1104f2a2fb6489b5 May 13 23:41:32.406505 systemd-resolved[288]: Positive Trust Anchors: May 13 23:41:32.407023 systemd-resolved[288]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 13 23:41:32.407087 systemd-resolved[288]: 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 May 13 23:41:32.536155 kernel: SCSI subsystem initialized May 13 23:41:32.544234 kernel: Loading iSCSI transport class v2.0-870. May 13 23:41:32.556218 kernel: iscsi: registered transport (tcp) May 13 23:41:32.578433 kernel: iscsi: registered transport (qla4xxx) May 13 23:41:32.578517 kernel: QLogic iSCSI HBA Driver May 13 23:41:32.659154 kernel: random: crng init done May 13 23:41:32.657439 systemd-resolved[288]: Defaulting to hostname 'linux'. May 13 23:41:32.663337 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 13 23:41:32.673079 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 13 23:41:32.681228 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 13 23:41:32.689295 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 13 23:41:32.737198 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 13 23:41:32.737344 kernel: device-mapper: uevent: version 1.0.3 May 13 23:41:32.739308 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com May 13 23:41:32.804165 kernel: raid6: neonx8 gen() 6496 MB/s May 13 23:41:32.821143 kernel: raid6: neonx4 gen() 6493 MB/s May 13 23:41:32.838139 kernel: raid6: neonx2 gen() 5444 MB/s May 13 23:41:32.855140 kernel: raid6: neonx1 gen() 3938 MB/s May 13 23:41:32.872139 kernel: raid6: int64x8 gen() 3602 MB/s May 13 23:41:32.889140 kernel: raid6: int64x4 gen() 3700 MB/s May 13 23:41:32.906139 kernel: raid6: int64x2 gen() 3591 MB/s May 13 23:41:32.923963 kernel: raid6: int64x1 gen() 2745 MB/s May 13 23:41:32.924004 kernel: raid6: using algorithm neonx8 gen() 6496 MB/s May 13 23:41:32.941969 kernel: raid6: .... xor() 4814 MB/s, rmw enabled May 13 23:41:32.942011 kernel: raid6: using neon recovery algorithm May 13 23:41:32.949144 kernel: xor: measuring software checksum speed May 13 23:41:32.949202 kernel: 8regs : 11926 MB/sec May 13 23:41:32.952335 kernel: 32regs : 11854 MB/sec May 13 23:41:32.952367 kernel: arm64_neon : 9540 MB/sec May 13 23:41:32.952391 kernel: xor: using function: 8regs (11926 MB/sec) May 13 23:41:33.036165 kernel: Btrfs loaded, zoned=no, fsverity=no May 13 23:41:33.055471 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 13 23:41:33.061619 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 13 23:41:33.107838 systemd-udevd[472]: Using default interface naming scheme 'v255'. May 13 23:41:33.118788 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 13 23:41:33.125495 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 13 23:41:33.165581 dracut-pre-trigger[476]: rd.md=0: removing MD RAID activation May 13 23:41:33.219083 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 13 23:41:33.226221 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 13 23:41:33.358168 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 13 23:41:33.366329 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 13 23:41:33.408269 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 13 23:41:33.410839 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 13 23:41:33.425757 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 13 23:41:33.428091 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 13 23:41:33.453604 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 13 23:41:33.511178 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 13 23:41:33.563623 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 May 13 23:41:33.563721 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) May 13 23:41:33.579116 kernel: ena 0000:00:05.0: ENA device version: 0.10 May 13 23:41:33.579614 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 May 13 23:41:33.600363 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:d5:99:f1:5f:1d May 13 23:41:33.600739 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 May 13 23:41:33.602135 kernel: nvme nvme0: pci function 0000:00:04.0 May 13 23:41:33.602413 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 13 23:41:33.602663 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 13 23:41:33.607579 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 13 23:41:33.612603 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 13 23:41:33.615329 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 13 23:41:33.623260 kernel: nvme nvme0: 2/0/0 default/read/poll queues May 13 23:41:33.623164 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 13 23:41:33.628804 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 13 23:41:33.634459 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. May 13 23:41:33.642136 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. May 13 23:41:33.642204 kernel: GPT:9289727 != 16777215 May 13 23:41:33.642229 kernel: GPT:Alternate GPT header not at the end of the disk. May 13 23:41:33.643194 kernel: GPT:9289727 != 16777215 May 13 23:41:33.643275 kernel: GPT: Use GNU Parted to correct GPT errors. May 13 23:41:33.643301 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 13 23:41:33.649622 (udev-worker)[518]: Network interface NamePolicy= disabled on kernel command line. May 13 23:41:33.680279 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 13 23:41:33.689975 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 13 23:41:33.741068 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 13 23:41:33.766295 kernel: BTRFS: device fsid ee830c17-a93d-4109-bd12-3fec8ef6763d devid 1 transid 41 /dev/nvme0n1p3 scanned by (udev-worker) (520) May 13 23:41:33.790182 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by (udev-worker) (537) May 13 23:41:33.858400 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. May 13 23:41:33.891100 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. May 13 23:41:33.897281 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. May 13 23:41:33.926901 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. May 13 23:41:33.952819 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. May 13 23:41:33.990052 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 13 23:41:34.020622 disk-uuid[661]: Primary Header is updated. May 13 23:41:34.020622 disk-uuid[661]: Secondary Entries is updated. May 13 23:41:34.020622 disk-uuid[661]: Secondary Header is updated. May 13 23:41:34.031194 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 13 23:41:35.051179 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 13 23:41:35.052399 disk-uuid[663]: The operation has completed successfully. May 13 23:41:35.241697 systemd[1]: disk-uuid.service: Deactivated successfully. May 13 23:41:35.243646 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 13 23:41:35.324528 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 13 23:41:35.348304 sh[923]: Success May 13 23:41:35.373151 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" May 13 23:41:35.505282 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 13 23:41:35.514291 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 13 23:41:35.530479 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 13 23:41:35.557142 kernel: BTRFS info (device dm-0): first mount of filesystem ee830c17-a93d-4109-bd12-3fec8ef6763d May 13 23:41:35.557218 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm May 13 23:41:35.557247 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead May 13 23:41:35.560390 kernel: BTRFS info (device dm-0): disabling log replay at mount time May 13 23:41:35.560426 kernel: BTRFS info (device dm-0): using free space tree May 13 23:41:35.694157 kernel: BTRFS info (device dm-0): enabling ssd optimizations May 13 23:41:35.721060 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 13 23:41:35.723615 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 13 23:41:35.728332 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 13 23:41:35.735385 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 13 23:41:35.792247 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem e7b30525-8b14-4004-ad68-68a99b3959db May 13 23:41:35.792309 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm May 13 23:41:35.793864 kernel: BTRFS info (device nvme0n1p6): using free space tree May 13 23:41:35.802186 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations May 13 23:41:35.810168 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem e7b30525-8b14-4004-ad68-68a99b3959db May 13 23:41:35.812878 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 13 23:41:35.819472 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 13 23:41:35.913165 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 13 23:41:35.923387 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 13 23:41:35.983529 systemd-networkd[1113]: lo: Link UP May 13 23:41:35.983552 systemd-networkd[1113]: lo: Gained carrier May 13 23:41:35.988984 systemd-networkd[1113]: Enumeration completed May 13 23:41:35.989663 systemd[1]: Started systemd-networkd.service - Network Configuration. May 13 23:41:35.989689 systemd-networkd[1113]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 13 23:41:35.989696 systemd-networkd[1113]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 13 23:41:35.992218 systemd[1]: Reached target network.target - Network. May 13 23:41:36.006085 systemd-networkd[1113]: eth0: Link UP May 13 23:41:36.006092 systemd-networkd[1113]: eth0: Gained carrier May 13 23:41:36.006163 systemd-networkd[1113]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 13 23:41:36.021186 systemd-networkd[1113]: eth0: DHCPv4 address 172.31.20.123/20, gateway 172.31.16.1 acquired from 172.31.16.1 May 13 23:41:36.206082 ignition[1038]: Ignition 2.20.0 May 13 23:41:36.206133 ignition[1038]: Stage: fetch-offline May 13 23:41:36.206561 ignition[1038]: no configs at "/usr/lib/ignition/base.d" May 13 23:41:36.206587 ignition[1038]: no config dir at "/usr/lib/ignition/base.platform.d/aws" May 13 23:41:36.213063 ignition[1038]: Ignition finished successfully May 13 23:41:36.216821 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 13 23:41:36.223321 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... May 13 23:41:36.258288 ignition[1124]: Ignition 2.20.0 May 13 23:41:36.258317 ignition[1124]: Stage: fetch May 13 23:41:36.259872 ignition[1124]: no configs at "/usr/lib/ignition/base.d" May 13 23:41:36.259899 ignition[1124]: no config dir at "/usr/lib/ignition/base.platform.d/aws" May 13 23:41:36.260341 ignition[1124]: PUT http://169.254.169.254/latest/api/token: attempt #1 May 13 23:41:36.283227 ignition[1124]: PUT result: OK May 13 23:41:36.286241 ignition[1124]: parsed url from cmdline: "" May 13 23:41:36.286264 ignition[1124]: no config URL provided May 13 23:41:36.286283 ignition[1124]: reading system config file "/usr/lib/ignition/user.ign" May 13 23:41:36.286337 ignition[1124]: no config at "/usr/lib/ignition/user.ign" May 13 23:41:36.286398 ignition[1124]: PUT http://169.254.169.254/latest/api/token: attempt #1 May 13 23:41:36.291736 ignition[1124]: PUT result: OK May 13 23:41:36.291867 ignition[1124]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 May 13 23:41:36.297527 ignition[1124]: GET result: OK May 13 23:41:36.297610 ignition[1124]: parsing config with SHA512: 260c5042df9414cc4f69aec593c85b271d52814e11c6faa36318290c62cf29ec7d30967780b659fedc314a7ec7414e1917ae07d2af1ee7468ae7f8d9fee0c149 May 13 23:41:36.304546 unknown[1124]: fetched base config from "system" May 13 23:41:36.304768 unknown[1124]: fetched base config from "system" May 13 23:41:36.305039 ignition[1124]: fetch: fetch complete May 13 23:41:36.304783 unknown[1124]: fetched user config from "aws" May 13 23:41:36.305067 ignition[1124]: fetch: fetch passed May 13 23:41:36.305173 ignition[1124]: Ignition finished successfully May 13 23:41:36.317331 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). May 13 23:41:36.322562 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 13 23:41:36.367436 ignition[1130]: Ignition 2.20.0 May 13 23:41:36.367465 ignition[1130]: Stage: kargs May 13 23:41:36.368427 ignition[1130]: no configs at "/usr/lib/ignition/base.d" May 13 23:41:36.368453 ignition[1130]: no config dir at "/usr/lib/ignition/base.platform.d/aws" May 13 23:41:36.368608 ignition[1130]: PUT http://169.254.169.254/latest/api/token: attempt #1 May 13 23:41:36.376393 ignition[1130]: PUT result: OK May 13 23:41:36.380062 ignition[1130]: kargs: kargs passed May 13 23:41:36.380358 ignition[1130]: Ignition finished successfully May 13 23:41:36.385514 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 13 23:41:36.390856 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 13 23:41:36.427390 ignition[1138]: Ignition 2.20.0 May 13 23:41:36.427415 ignition[1138]: Stage: disks May 13 23:41:36.429022 ignition[1138]: no configs at "/usr/lib/ignition/base.d" May 13 23:41:36.429049 ignition[1138]: no config dir at "/usr/lib/ignition/base.platform.d/aws" May 13 23:41:36.429228 ignition[1138]: PUT http://169.254.169.254/latest/api/token: attempt #1 May 13 23:41:36.432596 ignition[1138]: PUT result: OK May 13 23:41:36.440390 ignition[1138]: disks: disks passed May 13 23:41:36.441804 ignition[1138]: Ignition finished successfully May 13 23:41:36.446198 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 13 23:41:36.450374 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 13 23:41:36.454504 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 13 23:41:36.456838 systemd[1]: Reached target local-fs.target - Local File Systems. May 13 23:41:36.458767 systemd[1]: Reached target sysinit.target - System Initialization. May 13 23:41:36.460714 systemd[1]: Reached target basic.target - Basic System. May 13 23:41:36.471573 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 13 23:41:36.529324 systemd-fsck[1146]: ROOT: clean, 14/553520 files, 52654/553472 blocks May 13 23:41:36.536194 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 13 23:41:36.544277 systemd[1]: Mounting sysroot.mount - /sysroot... May 13 23:41:36.632213 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 9f8d74e6-c079-469f-823a-18a62077a2c7 r/w with ordered data mode. Quota mode: none. May 13 23:41:36.633646 systemd[1]: Mounted sysroot.mount - /sysroot. May 13 23:41:36.637222 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 13 23:41:36.650838 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 13 23:41:36.657287 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 13 23:41:36.661443 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 13 23:41:36.662047 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 13 23:41:36.662103 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 13 23:41:36.689013 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 13 23:41:36.694542 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 13 23:41:36.714150 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by mount (1165) May 13 23:41:36.719312 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem e7b30525-8b14-4004-ad68-68a99b3959db May 13 23:41:36.719371 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm May 13 23:41:36.719398 kernel: BTRFS info (device nvme0n1p6): using free space tree May 13 23:41:36.735179 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations May 13 23:41:36.736800 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 13 23:41:37.063686 initrd-setup-root[1189]: cut: /sysroot/etc/passwd: No such file or directory May 13 23:41:37.073584 initrd-setup-root[1196]: cut: /sysroot/etc/group: No such file or directory May 13 23:41:37.081828 initrd-setup-root[1203]: cut: /sysroot/etc/shadow: No such file or directory May 13 23:41:37.090067 initrd-setup-root[1210]: cut: /sysroot/etc/gshadow: No such file or directory May 13 23:41:37.340424 systemd-networkd[1113]: eth0: Gained IPv6LL May 13 23:41:37.385244 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 13 23:41:37.391182 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 13 23:41:37.397232 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 13 23:41:37.422291 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 13 23:41:37.428140 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem e7b30525-8b14-4004-ad68-68a99b3959db May 13 23:41:37.461650 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 13 23:41:37.475679 ignition[1278]: INFO : Ignition 2.20.0 May 13 23:41:37.475679 ignition[1278]: INFO : Stage: mount May 13 23:41:37.480051 ignition[1278]: INFO : no configs at "/usr/lib/ignition/base.d" May 13 23:41:37.480051 ignition[1278]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" May 13 23:41:37.480051 ignition[1278]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 May 13 23:41:37.480051 ignition[1278]: INFO : PUT result: OK May 13 23:41:37.493211 ignition[1278]: INFO : mount: mount passed May 13 23:41:37.493211 ignition[1278]: INFO : Ignition finished successfully May 13 23:41:37.490307 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 13 23:41:37.501254 systemd[1]: Starting ignition-files.service - Ignition (files)... May 13 23:41:37.636239 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 13 23:41:37.682152 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/nvme0n1p6 scanned by mount (1289) May 13 23:41:37.686321 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem e7b30525-8b14-4004-ad68-68a99b3959db May 13 23:41:37.686376 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm May 13 23:41:37.686403 kernel: BTRFS info (device nvme0n1p6): using free space tree May 13 23:41:37.694164 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations May 13 23:41:37.696345 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 13 23:41:37.735086 ignition[1306]: INFO : Ignition 2.20.0 May 13 23:41:37.735086 ignition[1306]: INFO : Stage: files May 13 23:41:37.738334 ignition[1306]: INFO : no configs at "/usr/lib/ignition/base.d" May 13 23:41:37.738334 ignition[1306]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" May 13 23:41:37.738334 ignition[1306]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 May 13 23:41:37.756424 ignition[1306]: INFO : PUT result: OK May 13 23:41:37.761782 ignition[1306]: DEBUG : files: compiled without relabeling support, skipping May 13 23:41:37.765431 ignition[1306]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 13 23:41:37.765431 ignition[1306]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 13 23:41:37.784492 ignition[1306]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 13 23:41:37.787376 ignition[1306]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 13 23:41:37.790496 unknown[1306]: wrote ssh authorized keys file for user: core May 13 23:41:37.792657 ignition[1306]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 13 23:41:37.797304 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 13 23:41:37.801149 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 13 23:41:37.804597 ignition[1306]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" May 13 23:41:37.807907 ignition[1306]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" May 13 23:41:37.807907 ignition[1306]: INFO : files: files passed May 13 23:41:37.807907 ignition[1306]: INFO : Ignition finished successfully May 13 23:41:37.816232 systemd[1]: Finished ignition-files.service - Ignition (files). May 13 23:41:37.821584 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 13 23:41:37.830375 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 13 23:41:37.849267 systemd[1]: ignition-quench.service: Deactivated successfully. May 13 23:41:37.851251 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 13 23:41:37.866971 initrd-setup-root-after-ignition[1336]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 13 23:41:37.866971 initrd-setup-root-after-ignition[1336]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 13 23:41:37.874626 initrd-setup-root-after-ignition[1340]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 13 23:41:37.882164 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 13 23:41:37.882805 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 13 23:41:37.887359 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 13 23:41:37.955833 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 13 23:41:37.956293 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 13 23:41:37.963028 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 13 23:41:37.965302 systemd[1]: Reached target initrd.target - Initrd Default Target. May 13 23:41:37.967639 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 13 23:41:37.970817 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 13 23:41:38.018186 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 13 23:41:38.025868 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 13 23:41:38.058638 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 13 23:41:38.061258 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 13 23:41:38.065734 systemd[1]: Stopped target timers.target - Timer Units. May 13 23:41:38.071178 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 13 23:41:38.071446 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 13 23:41:38.076070 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 13 23:41:38.082241 systemd[1]: Stopped target basic.target - Basic System. May 13 23:41:38.085277 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 13 23:41:38.089101 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 13 23:41:38.092199 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 13 23:41:38.094610 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 13 23:41:38.102582 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 13 23:41:38.105723 systemd[1]: Stopped target sysinit.target - System Initialization. May 13 23:41:38.112829 systemd[1]: Stopped target local-fs.target - Local File Systems. May 13 23:41:38.115131 systemd[1]: Stopped target swap.target - Swaps. May 13 23:41:38.120329 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 13 23:41:38.120566 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 13 23:41:38.123682 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 13 23:41:38.126004 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 13 23:41:38.128461 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 13 23:41:38.130333 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 13 23:41:38.133837 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 13 23:41:38.134061 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 13 23:41:38.150721 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 13 23:41:38.150952 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 13 23:41:38.155763 systemd[1]: ignition-files.service: Deactivated successfully. May 13 23:41:38.156264 systemd[1]: Stopped ignition-files.service - Ignition (files). May 13 23:41:38.167523 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 13 23:41:38.175819 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 13 23:41:38.177699 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 13 23:41:38.177967 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 13 23:41:38.185468 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 13 23:41:38.185696 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 13 23:41:38.201319 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 13 23:41:38.203458 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 13 23:41:38.230714 ignition[1360]: INFO : Ignition 2.20.0 May 13 23:41:38.230714 ignition[1360]: INFO : Stage: umount May 13 23:41:38.235050 ignition[1360]: INFO : no configs at "/usr/lib/ignition/base.d" May 13 23:41:38.235050 ignition[1360]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" May 13 23:41:38.235050 ignition[1360]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 May 13 23:41:38.241845 ignition[1360]: INFO : PUT result: OK May 13 23:41:38.243622 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 13 23:41:38.249179 ignition[1360]: INFO : umount: umount passed May 13 23:41:38.251276 ignition[1360]: INFO : Ignition finished successfully May 13 23:41:38.254083 systemd[1]: ignition-mount.service: Deactivated successfully. May 13 23:41:38.254326 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 13 23:41:38.261189 systemd[1]: sysroot-boot.service: Deactivated successfully. May 13 23:41:38.261756 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 13 23:41:38.266699 systemd[1]: ignition-disks.service: Deactivated successfully. May 13 23:41:38.266876 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 13 23:41:38.270579 systemd[1]: ignition-kargs.service: Deactivated successfully. May 13 23:41:38.270680 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 13 23:41:38.275278 systemd[1]: ignition-fetch.service: Deactivated successfully. May 13 23:41:38.275371 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). May 13 23:41:38.284089 systemd[1]: Stopped target network.target - Network. May 13 23:41:38.285838 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 13 23:41:38.286909 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 13 23:41:38.289882 systemd[1]: Stopped target paths.target - Path Units. May 13 23:41:38.293284 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 13 23:41:38.299155 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 13 23:41:38.301598 systemd[1]: Stopped target slices.target - Slice Units. May 13 23:41:38.307581 systemd[1]: Stopped target sockets.target - Socket Units. May 13 23:41:38.309965 systemd[1]: iscsid.socket: Deactivated successfully. May 13 23:41:38.310054 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 13 23:41:38.312964 systemd[1]: iscsiuio.socket: Deactivated successfully. May 13 23:41:38.313034 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 13 23:41:38.315025 systemd[1]: ignition-setup.service: Deactivated successfully. May 13 23:41:38.315125 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 13 23:41:38.317127 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 13 23:41:38.317579 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 13 23:41:38.320708 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 13 23:41:38.320790 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 13 23:41:38.323332 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 13 23:41:38.326633 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 13 23:41:38.350541 systemd[1]: systemd-resolved.service: Deactivated successfully. May 13 23:41:38.354191 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 13 23:41:38.362350 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. May 13 23:41:38.364923 systemd[1]: systemd-networkd.service: Deactivated successfully. May 13 23:41:38.366746 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 13 23:41:38.372493 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. May 13 23:41:38.376615 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 13 23:41:38.376724 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 13 23:41:38.385256 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 13 23:41:38.391829 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 13 23:41:38.391940 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 13 23:41:38.400794 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 13 23:41:38.400893 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 13 23:41:38.405979 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 13 23:41:38.406066 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 13 23:41:38.413227 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 13 23:41:38.413314 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 13 23:41:38.417903 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 13 23:41:38.448845 systemd[1]: systemd-udevd.service: Deactivated successfully. May 13 23:41:38.451338 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 13 23:41:38.458449 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 13 23:41:38.458571 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 13 23:41:38.460893 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 13 23:41:38.461263 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 13 23:41:38.464759 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 13 23:41:38.464850 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 13 23:41:38.467081 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 13 23:41:38.467186 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 13 23:41:38.481586 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 13 23:41:38.482031 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 13 23:41:38.497529 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 13 23:41:38.500813 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 13 23:41:38.500927 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 13 23:41:38.518875 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. May 13 23:41:38.519741 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 13 23:41:38.524945 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 13 23:41:38.525032 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 13 23:41:38.527343 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 13 23:41:38.527422 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 13 23:41:38.544089 systemd[1]: network-cleanup.service: Deactivated successfully. May 13 23:41:38.544807 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 13 23:41:38.560481 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 13 23:41:38.560878 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 13 23:41:38.568835 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 13 23:41:38.573943 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 13 23:41:38.606429 systemd[1]: Switching root. May 13 23:41:38.673799 systemd-journald[250]: Journal stopped May 13 23:41:40.649020 systemd-journald[250]: Received SIGTERM from PID 1 (systemd). May 13 23:41:40.649157 kernel: SELinux: policy capability network_peer_controls=1 May 13 23:41:40.649201 kernel: SELinux: policy capability open_perms=1 May 13 23:41:40.649232 kernel: SELinux: policy capability extended_socket_class=1 May 13 23:41:40.649261 kernel: SELinux: policy capability always_check_network=0 May 13 23:41:40.649289 kernel: SELinux: policy capability cgroup_seclabel=1 May 13 23:41:40.649324 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 13 23:41:40.649354 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 13 23:41:40.649382 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 13 23:41:40.649410 kernel: audit: type=1403 audit(1747179698.868:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 13 23:41:40.649475 systemd[1]: Successfully loaded SELinux policy in 51.059ms. May 13 23:41:40.649535 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 24.088ms. May 13 23:41:40.649573 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 13 23:41:40.649604 systemd[1]: Detected virtualization amazon. May 13 23:41:40.649634 systemd[1]: Detected architecture arm64. May 13 23:41:40.649668 systemd[1]: Detected first boot. May 13 23:41:40.649698 systemd[1]: Initializing machine ID from VM UUID. May 13 23:41:40.649728 zram_generator::config[1405]: No configuration found. May 13 23:41:40.649762 kernel: NET: Registered PF_VSOCK protocol family May 13 23:41:40.649791 systemd[1]: Populated /etc with preset unit settings. May 13 23:41:40.649825 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. May 13 23:41:40.649864 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 13 23:41:40.649895 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 13 23:41:40.649930 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 13 23:41:40.649959 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 13 23:41:40.649993 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 13 23:41:40.650032 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 13 23:41:40.650063 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 13 23:41:40.650097 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 13 23:41:40.654197 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 13 23:41:40.654241 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 13 23:41:40.654271 systemd[1]: Created slice user.slice - User and Session Slice. May 13 23:41:40.654302 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 13 23:41:40.654334 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 13 23:41:40.654363 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 13 23:41:40.654394 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 13 23:41:40.654423 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 13 23:41:40.654477 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 13 23:41:40.654511 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... May 13 23:41:40.654542 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 13 23:41:40.654573 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 13 23:41:40.654607 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 13 23:41:40.654638 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 13 23:41:40.654668 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 13 23:41:40.654702 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 13 23:41:40.654732 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 13 23:41:40.654763 systemd[1]: Reached target slices.target - Slice Units. May 13 23:41:40.654793 systemd[1]: Reached target swap.target - Swaps. May 13 23:41:40.654822 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 13 23:41:40.654850 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 13 23:41:40.654879 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 13 23:41:40.654911 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 13 23:41:40.654942 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 13 23:41:40.654971 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 13 23:41:40.655004 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 13 23:41:40.655032 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 13 23:41:40.655061 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 13 23:41:40.655092 systemd[1]: Mounting media.mount - External Media Directory... May 13 23:41:40.657195 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 13 23:41:40.657240 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 13 23:41:40.657269 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 13 23:41:40.657299 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). May 13 23:41:40.657343 systemd[1]: Reached target machines.target - Containers. May 13 23:41:40.657372 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 13 23:41:40.657400 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 13 23:41:40.657429 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 13 23:41:40.657477 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 13 23:41:40.657526 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 13 23:41:40.657558 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 13 23:41:40.657597 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 13 23:41:40.657632 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 13 23:41:40.657669 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 13 23:41:40.657700 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 13 23:41:40.657730 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 13 23:41:40.657759 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 13 23:41:40.657791 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 13 23:41:40.657821 systemd[1]: Stopped systemd-fsck-usr.service. May 13 23:41:40.657852 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). May 13 23:41:40.657881 systemd[1]: Starting systemd-journald.service - Journal Service... May 13 23:41:40.657917 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 13 23:41:40.657948 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 13 23:41:40.657980 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 13 23:41:40.658012 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 13 23:41:40.658046 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 13 23:41:40.658077 systemd[1]: verity-setup.service: Deactivated successfully. May 13 23:41:40.660149 systemd[1]: Stopped verity-setup.service. May 13 23:41:40.660211 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 13 23:41:40.660242 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 13 23:41:40.660270 systemd[1]: Mounted media.mount - External Media Directory. May 13 23:41:40.660299 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 13 23:41:40.660327 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 13 23:41:40.660359 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 13 23:41:40.660387 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 13 23:41:40.660420 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 13 23:41:40.660448 kernel: loop: module loaded May 13 23:41:40.660477 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 13 23:41:40.660508 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 13 23:41:40.660540 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 13 23:41:40.660573 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 13 23:41:40.660602 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 13 23:41:40.660631 systemd[1]: modprobe@loop.service: Deactivated successfully. May 13 23:41:40.660659 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 13 23:41:40.660689 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 13 23:41:40.660721 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 13 23:41:40.660755 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 13 23:41:40.660785 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 13 23:41:40.660813 systemd[1]: Reached target local-fs.target - Local File Systems. May 13 23:41:40.660847 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 13 23:41:40.660876 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 13 23:41:40.660908 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 13 23:41:40.660935 kernel: fuse: init (API version 7.39) May 13 23:41:40.660963 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 13 23:41:40.661042 systemd-journald[1489]: Collecting audit messages is disabled. May 13 23:41:40.661091 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 13 23:41:40.661147 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 13 23:41:40.661184 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 13 23:41:40.661213 systemd-journald[1489]: Journal started May 13 23:41:40.661261 systemd-journald[1489]: Runtime Journal (/run/log/journal/ec212c097a81cc5f002a10712061db2e) is 8M, max 75.3M, 67.3M free. May 13 23:41:40.058327 systemd[1]: Queued start job for default target multi-user.target. May 13 23:41:40.071432 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. May 13 23:41:40.668240 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 13 23:41:40.072302 systemd[1]: systemd-journald.service: Deactivated successfully. May 13 23:41:40.678183 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 13 23:41:40.693460 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 13 23:41:40.710483 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 13 23:41:40.723033 systemd[1]: Started systemd-journald.service - Journal Service. May 13 23:41:40.724956 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 13 23:41:40.728219 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 13 23:41:40.734225 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 13 23:41:40.737061 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 13 23:41:40.755963 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 13 23:41:40.762200 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 13 23:41:40.786141 kernel: ACPI: bus type drm_connector registered May 13 23:41:40.797705 systemd[1]: modprobe@drm.service: Deactivated successfully. May 13 23:41:40.800233 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 13 23:41:40.814294 systemd[1]: Reached target network-pre.target - Preparation for Network. May 13 23:41:40.824494 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 13 23:41:40.841345 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 13 23:41:40.857230 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 13 23:41:40.860704 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 13 23:41:40.887353 kernel: loop0: detected capacity change from 0 to 103832 May 13 23:41:40.872086 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 13 23:41:40.875358 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 13 23:41:40.880639 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 13 23:41:40.933179 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 13 23:41:40.933730 systemd-tmpfiles[1520]: ACLs are not supported, ignoring. May 13 23:41:40.933755 systemd-tmpfiles[1520]: ACLs are not supported, ignoring. May 13 23:41:40.939683 systemd-journald[1489]: Time spent on flushing to /var/log/journal/ec212c097a81cc5f002a10712061db2e is 93.666ms for 898 entries. May 13 23:41:40.939683 systemd-journald[1489]: System Journal (/var/log/journal/ec212c097a81cc5f002a10712061db2e) is 8M, max 195.6M, 187.6M free. May 13 23:41:41.060916 systemd-journald[1489]: Received client request to flush runtime journal. May 13 23:41:41.061013 kernel: loop1: detected capacity change from 0 to 54976 May 13 23:41:40.951986 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 13 23:41:40.960713 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 13 23:41:40.994229 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 13 23:41:41.029851 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 13 23:41:41.069593 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 13 23:41:41.078193 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 13 23:41:41.107890 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 13 23:41:41.115576 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 13 23:41:41.152066 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 13 23:41:41.159792 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... May 13 23:41:41.175170 kernel: loop2: detected capacity change from 0 to 126448 May 13 23:41:41.206451 systemd-tmpfiles[1562]: ACLs are not supported, ignoring. May 13 23:41:41.206485 systemd-tmpfiles[1562]: ACLs are not supported, ignoring. May 13 23:41:41.220772 udevadm[1566]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. May 13 23:41:41.235529 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 13 23:41:41.322205 kernel: loop3: detected capacity change from 0 to 103832 May 13 23:41:41.352965 kernel: loop4: detected capacity change from 0 to 54976 May 13 23:41:41.371743 kernel: loop5: detected capacity change from 0 to 126448 May 13 23:41:41.392347 (sd-merge)[1569]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. May 13 23:41:41.395248 (sd-merge)[1569]: Merged extensions into '/usr'. May 13 23:41:41.404370 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 13 23:41:41.415574 systemd[1]: Starting ensure-sysext.service... May 13 23:41:41.421578 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 13 23:41:41.499716 systemd[1]: Reload requested from client PID 1571 ('systemctl') (unit ensure-sysext.service)... May 13 23:41:41.499743 systemd[1]: Reloading... May 13 23:41:41.509616 systemd-tmpfiles[1572]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 13 23:41:41.512534 systemd-tmpfiles[1572]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 13 23:41:41.517473 systemd-tmpfiles[1572]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 13 23:41:41.519731 systemd-tmpfiles[1572]: ACLs are not supported, ignoring. May 13 23:41:41.519895 systemd-tmpfiles[1572]: ACLs are not supported, ignoring. May 13 23:41:41.546235 systemd-tmpfiles[1572]: Detected autofs mount point /boot during canonicalization of boot. May 13 23:41:41.546261 systemd-tmpfiles[1572]: Skipping /boot May 13 23:41:41.638061 systemd-tmpfiles[1572]: Detected autofs mount point /boot during canonicalization of boot. May 13 23:41:41.640177 systemd-tmpfiles[1572]: Skipping /boot May 13 23:41:41.648153 zram_generator::config[1598]: No configuration found. May 13 23:41:41.845847 ldconfig[1511]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 13 23:41:41.999672 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. May 13 23:41:42.152879 systemd[1]: Reloading finished in 652 ms. May 13 23:41:42.179850 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 13 23:41:42.183542 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 13 23:41:42.235773 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 13 23:41:42.243565 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 13 23:41:42.252402 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 13 23:41:42.261613 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 13 23:41:42.271606 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 13 23:41:42.284504 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 13 23:41:42.287583 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 13 23:41:42.301641 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 13 23:41:42.314191 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 13 23:41:42.316503 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 13 23:41:42.316738 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). May 13 23:41:42.324091 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 13 23:41:42.325335 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 13 23:41:42.325929 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). May 13 23:41:42.335696 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 13 23:41:42.345923 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 13 23:41:42.353798 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 13 23:41:42.356616 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 13 23:41:42.357143 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). May 13 23:41:42.357535 systemd[1]: Reached target time-set.target - System Time Set. May 13 23:41:42.382253 systemd[1]: Finished ensure-sysext.service. May 13 23:41:42.387748 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 13 23:41:42.388857 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 13 23:41:42.391997 systemd[1]: modprobe@loop.service: Deactivated successfully. May 13 23:41:42.394516 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 13 23:41:42.405241 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 13 23:41:42.415097 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 13 23:41:42.421384 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 13 23:41:42.421918 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 13 23:41:42.425668 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 13 23:41:42.429971 systemd[1]: modprobe@drm.service: Deactivated successfully. May 13 23:41:42.430909 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 13 23:41:42.451270 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 13 23:41:42.455346 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 13 23:41:42.463937 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 13 23:41:42.470322 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 13 23:41:42.532328 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 13 23:41:42.548647 augenrules[1696]: No rules May 13 23:41:42.548761 systemd[1]: audit-rules.service: Deactivated successfully. May 13 23:41:42.549210 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 13 23:41:42.570553 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 13 23:41:42.585401 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 13 23:41:42.588717 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). May 13 23:41:42.606772 systemd-udevd[1687]: Using default interface naming scheme 'v255'. May 13 23:41:42.654286 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 13 23:41:42.663370 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 13 23:41:42.746768 systemd-resolved[1659]: Positive Trust Anchors: May 13 23:41:42.746803 systemd-resolved[1659]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 13 23:41:42.746872 systemd-resolved[1659]: 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 May 13 23:41:42.760742 systemd-resolved[1659]: Defaulting to hostname 'linux'. May 13 23:41:42.766787 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 13 23:41:42.769304 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 13 23:41:42.866914 (udev-worker)[1715]: Network interface NamePolicy= disabled on kernel command line. May 13 23:41:42.870900 systemd-networkd[1711]: lo: Link UP May 13 23:41:42.871435 systemd-networkd[1711]: lo: Gained carrier May 13 23:41:42.873315 systemd-networkd[1711]: Enumeration completed May 13 23:41:42.874192 systemd[1]: Started systemd-networkd.service - Network Configuration. May 13 23:41:42.876580 systemd[1]: Reached target network.target - Network. May 13 23:41:42.881004 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 13 23:41:42.888542 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 13 23:41:42.953427 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 13 23:41:42.969380 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. May 13 23:41:43.016046 systemd-networkd[1711]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 13 23:41:43.016281 systemd-networkd[1711]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 13 23:41:43.018957 systemd-networkd[1711]: eth0: Link UP May 13 23:41:43.019264 systemd-networkd[1711]: eth0: Gained carrier May 13 23:41:43.019297 systemd-networkd[1711]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 13 23:41:43.035261 systemd-networkd[1711]: eth0: DHCPv4 address 172.31.20.123/20, gateway 172.31.16.1 acquired from 172.31.16.1 May 13 23:41:43.061138 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (1724) May 13 23:41:43.260746 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 13 23:41:43.345764 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. May 13 23:41:43.350051 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 13 23:41:43.354199 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. May 13 23:41:43.359987 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... May 13 23:41:43.398087 lvm[1832]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 13 23:41:43.404815 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 13 23:41:43.438212 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 13 23:41:43.441657 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. May 13 23:41:43.445550 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 13 23:41:43.447842 systemd[1]: Reached target sysinit.target - System Initialization. May 13 23:41:43.450244 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 13 23:41:43.452755 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. May 13 23:41:43.455493 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 13 23:41:43.457891 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 13 23:41:43.461523 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 13 23:41:43.463982 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 13 23:41:43.464050 systemd[1]: Reached target paths.target - Path Units. May 13 23:41:43.465797 systemd[1]: Reached target timers.target - Timer Units. May 13 23:41:43.469480 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 13 23:41:43.474197 systemd[1]: Starting docker.socket - Docker Socket for the API... May 13 23:41:43.480865 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 13 23:41:43.484659 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). May 13 23:41:43.487253 systemd[1]: Reached target ssh-access.target - SSH Access Available. May 13 23:41:43.492954 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 13 23:41:43.495866 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 13 23:41:43.502395 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... May 13 23:41:43.508353 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 13 23:41:43.512697 systemd[1]: Reached target sockets.target - Socket Units. May 13 23:41:43.515634 systemd[1]: Reached target basic.target - Basic System. May 13 23:41:43.517764 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 13 23:41:43.517825 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 13 23:41:43.531303 systemd[1]: Starting containerd.service - containerd container runtime... May 13 23:41:43.534567 lvm[1841]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 13 23:41:43.537653 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... May 13 23:41:43.543576 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 13 23:41:43.550440 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 13 23:41:43.560392 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 13 23:41:43.562455 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). May 13 23:41:43.574569 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 13 23:41:43.589671 systemd[1]: Started ntpd.service - Network Time Service. May 13 23:41:43.598956 systemd[1]: Starting setup-oem.service - Setup OEM... May 13 23:41:43.611728 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 13 23:41:43.621257 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 13 23:41:43.635403 systemd[1]: Starting systemd-logind.service - User Login Management... May 13 23:41:43.639883 jq[1845]: false May 13 23:41:43.646895 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 13 23:41:43.648496 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 13 23:41:43.654496 systemd[1]: Starting update-engine.service - Update Engine... May 13 23:41:43.674732 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 13 23:41:43.681257 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. May 13 23:41:43.685341 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 13 23:41:43.689305 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 13 23:41:43.730703 extend-filesystems[1846]: Found loop3 May 13 23:41:43.730703 extend-filesystems[1846]: Found loop4 May 13 23:41:43.730703 extend-filesystems[1846]: Found loop5 May 13 23:41:43.730703 extend-filesystems[1846]: Found nvme0n1 May 13 23:41:43.730703 extend-filesystems[1846]: Found nvme0n1p1 May 13 23:41:43.730703 extend-filesystems[1846]: Found nvme0n1p2 May 13 23:41:43.730703 extend-filesystems[1846]: Found nvme0n1p3 May 13 23:41:43.730703 extend-filesystems[1846]: Found usr May 13 23:41:43.730703 extend-filesystems[1846]: Found nvme0n1p4 May 13 23:41:43.730703 extend-filesystems[1846]: Found nvme0n1p6 May 13 23:41:43.730703 extend-filesystems[1846]: Found nvme0n1p7 May 13 23:41:43.730703 extend-filesystems[1846]: Found nvme0n1p9 May 13 23:41:43.730703 extend-filesystems[1846]: Checking size of /dev/nvme0n1p9 May 13 23:41:43.751649 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 13 23:41:43.741480 dbus-daemon[1844]: [system] SELinux support is enabled May 13 23:41:43.763835 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 13 23:41:43.767072 dbus-daemon[1844]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1711 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") May 13 23:41:43.764296 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 13 23:41:43.788395 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). May 13 23:41:43.788478 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 13 23:41:43.792451 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). May 13 23:41:43.792496 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 13 23:41:43.797738 dbus-daemon[1844]: [system] Successfully activated service 'org.freedesktop.systemd1' May 13 23:41:43.816550 (ntainerd)[1870]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 13 23:41:43.827624 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... May 13 23:41:43.834013 systemd[1]: Finished setup-oem.service - Setup OEM. May 13 23:41:43.853168 jq[1857]: true May 13 23:41:43.861352 systemd[1]: motdgen.service: Deactivated successfully. May 13 23:41:43.864242 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 13 23:41:43.881469 update_engine[1856]: I20250513 23:41:43.881299 1856 main.cc:92] Flatcar Update Engine starting May 13 23:41:43.891073 update_engine[1856]: I20250513 23:41:43.886072 1856 update_check_scheduler.cc:74] Next update check in 2m22s May 13 23:41:43.886542 systemd[1]: Started update-engine.service - Update Engine. May 13 23:41:43.900208 extend-filesystems[1846]: Resized partition /dev/nvme0n1p9 May 13 23:41:43.914165 extend-filesystems[1891]: resize2fs 1.47.2 (1-Jan-2025) May 13 23:41:43.924292 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks May 13 23:41:43.920757 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 13 23:41:43.924441 jq[1886]: true May 13 23:41:43.961204 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: ntpd 4.2.8p17@1.4004-o Tue May 13 21:33:15 UTC 2025 (1): Starting May 13 23:41:43.961204 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp May 13 23:41:43.961204 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: ---------------------------------------------------- May 13 23:41:43.961204 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: ntp-4 is maintained by Network Time Foundation, May 13 23:41:43.961204 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: Inc. (NTF), a non-profit 501(c)(3) public-benefit May 13 23:41:43.961204 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: corporation. Support and training for ntp-4 are May 13 23:41:43.961204 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: available at https://www.nwtime.org/support May 13 23:41:43.961204 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: ---------------------------------------------------- May 13 23:41:43.956534 ntpd[1848]: ntpd 4.2.8p17@1.4004-o Tue May 13 21:33:15 UTC 2025 (1): Starting May 13 23:41:43.956580 ntpd[1848]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp May 13 23:41:43.956600 ntpd[1848]: ---------------------------------------------------- May 13 23:41:43.956619 ntpd[1848]: ntp-4 is maintained by Network Time Foundation, May 13 23:41:43.956638 ntpd[1848]: Inc. (NTF), a non-profit 501(c)(3) public-benefit May 13 23:41:43.956656 ntpd[1848]: corporation. Support and training for ntp-4 are May 13 23:41:43.956673 ntpd[1848]: available at https://www.nwtime.org/support May 13 23:41:43.956691 ntpd[1848]: ---------------------------------------------------- May 13 23:41:43.972721 ntpd[1848]: proto: precision = 0.096 usec (-23) May 13 23:41:43.979273 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: proto: precision = 0.096 usec (-23) May 13 23:41:43.979273 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: basedate set to 2025-05-01 May 13 23:41:43.979273 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: gps base set to 2025-05-04 (week 2365) May 13 23:41:43.973173 ntpd[1848]: basedate set to 2025-05-01 May 13 23:41:43.973199 ntpd[1848]: gps base set to 2025-05-04 (week 2365) May 13 23:41:43.986707 ntpd[1848]: Listen and drop on 0 v6wildcard [::]:123 May 13 23:41:43.988151 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: Listen and drop on 0 v6wildcard [::]:123 May 13 23:41:43.988317 ntpd[1848]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 13 23:41:43.989857 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 13 23:41:43.989857 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: Listen normally on 2 lo 127.0.0.1:123 May 13 23:41:43.989857 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: Listen normally on 3 eth0 172.31.20.123:123 May 13 23:41:43.989857 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: Listen normally on 4 lo [::1]:123 May 13 23:41:43.989857 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: bind(21) AF_INET6 fe80::4d5:99ff:fef1:5f1d%2#123 flags 0x11 failed: Cannot assign requested address May 13 23:41:43.989857 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: unable to create socket on eth0 (5) for fe80::4d5:99ff:fef1:5f1d%2#123 May 13 23:41:43.989857 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: failed to init interface for address fe80::4d5:99ff:fef1:5f1d%2 May 13 23:41:43.989857 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: Listening on routing socket on fd #21 for interface updates May 13 23:41:43.988593 ntpd[1848]: Listen normally on 2 lo 127.0.0.1:123 May 13 23:41:43.988654 ntpd[1848]: Listen normally on 3 eth0 172.31.20.123:123 May 13 23:41:43.988718 ntpd[1848]: Listen normally on 4 lo [::1]:123 May 13 23:41:43.988794 ntpd[1848]: bind(21) AF_INET6 fe80::4d5:99ff:fef1:5f1d%2#123 flags 0x11 failed: Cannot assign requested address May 13 23:41:43.988832 ntpd[1848]: unable to create socket on eth0 (5) for fe80::4d5:99ff:fef1:5f1d%2#123 May 13 23:41:43.988858 ntpd[1848]: failed to init interface for address fe80::4d5:99ff:fef1:5f1d%2 May 13 23:41:43.988907 ntpd[1848]: Listening on routing socket on fd #21 for interface updates May 13 23:41:43.999726 ntpd[1848]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 13 23:41:44.004471 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 13 23:41:44.004471 ntpd[1848]: 13 May 23:41:43 ntpd[1848]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 13 23:41:43.999786 ntpd[1848]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 13 23:41:44.026398 coreos-metadata[1843]: May 13 23:41:44.026 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 May 13 23:41:44.036820 coreos-metadata[1843]: May 13 23:41:44.036 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 May 13 23:41:44.045018 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 May 13 23:41:44.047269 coreos-metadata[1843]: May 13 23:41:44.047 INFO Fetch successful May 13 23:41:44.047538 coreos-metadata[1843]: May 13 23:41:44.047 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 May 13 23:41:44.053402 coreos-metadata[1843]: May 13 23:41:44.053 INFO Fetch successful May 13 23:41:44.053655 coreos-metadata[1843]: May 13 23:41:44.053 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 May 13 23:41:44.065421 coreos-metadata[1843]: May 13 23:41:44.058 INFO Fetch successful May 13 23:41:44.065421 coreos-metadata[1843]: May 13 23:41:44.059 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 May 13 23:41:44.065421 coreos-metadata[1843]: May 13 23:41:44.060 INFO Fetch successful May 13 23:41:44.065421 coreos-metadata[1843]: May 13 23:41:44.060 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 May 13 23:41:44.065421 coreos-metadata[1843]: May 13 23:41:44.062 INFO Fetch failed with 404: resource not found May 13 23:41:44.065421 coreos-metadata[1843]: May 13 23:41:44.062 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 May 13 23:41:44.066130 coreos-metadata[1843]: May 13 23:41:44.064 INFO Fetch successful May 13 23:41:44.066130 coreos-metadata[1843]: May 13 23:41:44.065 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 May 13 23:41:44.066779 coreos-metadata[1843]: May 13 23:41:44.066 INFO Fetch successful May 13 23:41:44.066779 coreos-metadata[1843]: May 13 23:41:44.066 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 May 13 23:41:44.067568 coreos-metadata[1843]: May 13 23:41:44.067 INFO Fetch successful May 13 23:41:44.067568 coreos-metadata[1843]: May 13 23:41:44.067 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 May 13 23:41:44.069158 extend-filesystems[1891]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required May 13 23:41:44.069158 extend-filesystems[1891]: old_desc_blocks = 1, new_desc_blocks = 1 May 13 23:41:44.069158 extend-filesystems[1891]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. May 13 23:41:44.077259 extend-filesystems[1846]: Resized filesystem in /dev/nvme0n1p9 May 13 23:41:44.091781 bash[1916]: Updated "/home/core/.ssh/authorized_keys" May 13 23:41:44.083281 systemd[1]: extend-filesystems.service: Deactivated successfully. May 13 23:41:44.092075 coreos-metadata[1843]: May 13 23:41:44.077 INFO Fetch successful May 13 23:41:44.092075 coreos-metadata[1843]: May 13 23:41:44.078 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 May 13 23:41:44.092075 coreos-metadata[1843]: May 13 23:41:44.081 INFO Fetch successful May 13 23:41:44.083772 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 13 23:41:44.101928 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 13 23:41:44.146519 systemd[1]: Starting sshkeys.service... May 13 23:41:44.226101 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. May 13 23:41:44.230756 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 13 23:41:44.243149 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (1722) May 13 23:41:44.275085 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. May 13 23:41:44.281984 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... May 13 23:41:44.351817 systemd-logind[1854]: Watching system buttons on /dev/input/event0 (Power Button) May 13 23:41:44.351872 systemd-logind[1854]: Watching system buttons on /dev/input/event1 (Sleep Button) May 13 23:41:44.361454 systemd-logind[1854]: New seat seat0. May 13 23:41:44.373767 systemd[1]: Started systemd-logind.service - User Login Management. May 13 23:41:44.454876 locksmithd[1889]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 13 23:41:44.509218 systemd-networkd[1711]: eth0: Gained IPv6LL May 13 23:41:44.521722 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 13 23:41:44.525454 systemd[1]: Reached target network-online.target - Network is Online. May 13 23:41:44.534673 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. May 13 23:41:44.544151 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 13 23:41:44.561715 systemd[1]: Started systemd-hostnamed.service - Hostname Service. May 13 23:41:44.572351 dbus-daemon[1844]: [system] Successfully activated service 'org.freedesktop.hostname1' May 13 23:41:44.574127 containerd[1870]: time="2025-05-13T23:41:44Z" 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 May 13 23:41:44.575595 dbus-daemon[1844]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=1881 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") May 13 23:41:44.579489 containerd[1870]: time="2025-05-13T23:41:44.578373884Z" level=info msg="starting containerd" revision=88aa2f531d6c2922003cc7929e51daf1c14caa0a version=v2.0.1 May 13 23:41:44.622660 systemd[1]: Starting polkit.service - Authorization Manager... May 13 23:41:44.650660 coreos-metadata[1941]: May 13 23:41:44.648 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 May 13 23:41:44.660159 coreos-metadata[1941]: May 13 23:41:44.657 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 May 13 23:41:44.660159 coreos-metadata[1941]: May 13 23:41:44.659 INFO Fetch successful May 13 23:41:44.660159 coreos-metadata[1941]: May 13 23:41:44.659 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 May 13 23:41:44.662442 coreos-metadata[1941]: May 13 23:41:44.661 INFO Fetch successful May 13 23:41:44.663892 unknown[1941]: wrote ssh authorized keys file for user: core May 13 23:41:44.696436 containerd[1870]: time="2025-05-13T23:41:44.693982329Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.488µs" May 13 23:41:44.696436 containerd[1870]: time="2025-05-13T23:41:44.694026825Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 13 23:41:44.696436 containerd[1870]: time="2025-05-13T23:41:44.694062873Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 13 23:41:44.697176 containerd[1870]: time="2025-05-13T23:41:44.697125153Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 13 23:41:44.701623 containerd[1870]: time="2025-05-13T23:41:44.698565225Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 13 23:41:44.701623 containerd[1870]: time="2025-05-13T23:41:44.698661069Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 13 23:41:44.701623 containerd[1870]: time="2025-05-13T23:41:44.698806233Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 13 23:41:44.701623 containerd[1870]: time="2025-05-13T23:41:44.698833917Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 13 23:41:44.706175 containerd[1870]: time="2025-05-13T23:41:44.705295161Z" 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 May 13 23:41:44.706175 containerd[1870]: time="2025-05-13T23:41:44.705382545Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 13 23:41:44.706175 containerd[1870]: time="2025-05-13T23:41:44.705418617Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 13 23:41:44.706175 containerd[1870]: time="2025-05-13T23:41:44.705461409Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 13 23:41:44.706175 containerd[1870]: time="2025-05-13T23:41:44.705707961Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 13 23:41:44.706547 containerd[1870]: time="2025-05-13T23:41:44.706509765Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 13 23:41:44.706709 containerd[1870]: time="2025-05-13T23:41:44.706677261Z" 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 May 13 23:41:44.706898 containerd[1870]: time="2025-05-13T23:41:44.706867113Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 13 23:41:44.711273 containerd[1870]: time="2025-05-13T23:41:44.710609769Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 13 23:41:44.714051 containerd[1870]: time="2025-05-13T23:41:44.713461629Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 13 23:41:44.714051 containerd[1870]: time="2025-05-13T23:41:44.713657385Z" level=info msg="metadata content store policy set" policy=shared May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.726451041Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.726586449Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.726685089Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.726722229Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.726890421Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.726923025Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.726953649Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.726984621Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.727025505Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.727054221Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.727079937Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 13 23:41:44.727262 containerd[1870]: time="2025-05-13T23:41:44.727160025Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730347933Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730424097Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730456989Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730485285Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730513485Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730543533Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730574877Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730602381Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730632897Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730661553Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730688421Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730893309Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.730923465Z" level=info msg="Start snapshots syncer" May 13 23:41:44.731185 containerd[1870]: time="2025-05-13T23:41:44.731001321Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 13 23:41:44.738212 update-ssh-keys[2024]: Updated "/home/core/.ssh/authorized_keys" May 13 23:41:44.738594 containerd[1870]: time="2025-05-13T23:41:44.737279865Z" 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\"}" May 13 23:41:44.738594 containerd[1870]: time="2025-05-13T23:41:44.737400345Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 13 23:41:44.738908 containerd[1870]: time="2025-05-13T23:41:44.737564541Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 13 23:41:44.738908 containerd[1870]: time="2025-05-13T23:41:44.737807625Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 13 23:41:44.738908 containerd[1870]: time="2025-05-13T23:41:44.737854077Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 13 23:41:44.738908 containerd[1870]: time="2025-05-13T23:41:44.737887533Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 13 23:41:44.738908 containerd[1870]: time="2025-05-13T23:41:44.737915301Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 13 23:41:44.738908 containerd[1870]: time="2025-05-13T23:41:44.737959521Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 13 23:41:44.738908 containerd[1870]: time="2025-05-13T23:41:44.737989017Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 13 23:41:44.738908 containerd[1870]: time="2025-05-13T23:41:44.738018729Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 13 23:41:44.738908 containerd[1870]: time="2025-05-13T23:41:44.738074313Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 13 23:41:44.742644 containerd[1870]: time="2025-05-13T23:41:44.739008585Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 13 23:41:44.742644 containerd[1870]: time="2025-05-13T23:41:44.742083465Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 13 23:41:44.739418 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.743970837Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744172569Z" 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 May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744206241Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744233145Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744255117Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744281397Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744309729Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744368589Z" level=info msg="runtime interface created" May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744383937Z" level=info msg="created NRI interface" May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744405717Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744436449Z" level=info msg="Connect containerd service" May 13 23:41:44.747260 containerd[1870]: time="2025-05-13T23:41:44.744504669Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 13 23:41:44.749383 systemd[1]: Finished sshkeys.service. May 13 23:41:44.767977 containerd[1870]: time="2025-05-13T23:41:44.767728569Z" 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" May 13 23:41:44.770453 polkitd[2019]: Started polkitd version 121 May 13 23:41:44.790210 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 13 23:41:44.831504 polkitd[2019]: Loading rules from directory /etc/polkit-1/rules.d May 13 23:41:44.837337 polkitd[2019]: Loading rules from directory /usr/share/polkit-1/rules.d May 13 23:41:44.848050 polkitd[2019]: Finished loading, compiling and executing 2 rules May 13 23:41:44.859819 dbus-daemon[1844]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' May 13 23:41:44.860835 systemd[1]: Started polkit.service - Authorization Manager. May 13 23:41:44.865701 polkitd[2019]: Acquired the name org.freedesktop.PolicyKit1 on the system bus May 13 23:41:44.880212 amazon-ssm-agent[2008]: Initializing new seelog logger May 13 23:41:44.880668 amazon-ssm-agent[2008]: New Seelog Logger Creation Complete May 13 23:41:44.880668 amazon-ssm-agent[2008]: 2025/05/13 23:41:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. May 13 23:41:44.880668 amazon-ssm-agent[2008]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. May 13 23:41:44.882744 amazon-ssm-agent[2008]: 2025/05/13 23:41:44 processing appconfig overrides May 13 23:41:44.883292 amazon-ssm-agent[2008]: 2025/05/13 23:41:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. May 13 23:41:44.883292 amazon-ssm-agent[2008]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. May 13 23:41:44.887155 amazon-ssm-agent[2008]: 2025-05-13 23:41:44 INFO Proxy environment variables: May 13 23:41:44.887155 amazon-ssm-agent[2008]: 2025/05/13 23:41:44 processing appconfig overrides May 13 23:41:44.887155 amazon-ssm-agent[2008]: 2025/05/13 23:41:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. May 13 23:41:44.887155 amazon-ssm-agent[2008]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. May 13 23:41:44.887155 amazon-ssm-agent[2008]: 2025/05/13 23:41:44 processing appconfig overrides May 13 23:41:44.889804 amazon-ssm-agent[2008]: 2025/05/13 23:41:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. May 13 23:41:44.889804 amazon-ssm-agent[2008]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. May 13 23:41:44.889993 amazon-ssm-agent[2008]: 2025/05/13 23:41:44 processing appconfig overrides May 13 23:41:44.926345 systemd-hostnamed[1881]: Hostname set to (transient) May 13 23:41:44.929213 systemd-resolved[1659]: System hostname changed to 'ip-172-31-20-123'. May 13 23:41:44.986057 amazon-ssm-agent[2008]: 2025-05-13 23:41:44 INFO https_proxy: May 13 23:41:45.085614 amazon-ssm-agent[2008]: 2025-05-13 23:41:44 INFO http_proxy: May 13 23:41:45.140561 containerd[1870]: time="2025-05-13T23:41:45.140024983Z" level=info msg="Start subscribing containerd event" May 13 23:41:45.140561 containerd[1870]: time="2025-05-13T23:41:45.140096803Z" level=info msg="Start recovering state" May 13 23:41:45.140561 containerd[1870]: time="2025-05-13T23:41:45.140263567Z" level=info msg="Start event monitor" May 13 23:41:45.140561 containerd[1870]: time="2025-05-13T23:41:45.140291491Z" level=info msg="Start cni network conf syncer for default" May 13 23:41:45.140561 containerd[1870]: time="2025-05-13T23:41:45.140309899Z" level=info msg="Start streaming server" May 13 23:41:45.140561 containerd[1870]: time="2025-05-13T23:41:45.140328667Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 13 23:41:45.140561 containerd[1870]: time="2025-05-13T23:41:45.140345491Z" level=info msg="runtime interface starting up..." May 13 23:41:45.140561 containerd[1870]: time="2025-05-13T23:41:45.140362867Z" level=info msg="starting plugins..." May 13 23:41:45.140561 containerd[1870]: time="2025-05-13T23:41:45.140393983Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 13 23:41:45.145370 containerd[1870]: time="2025-05-13T23:41:45.142751815Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 13 23:41:45.145370 containerd[1870]: time="2025-05-13T23:41:45.142924195Z" level=info msg=serving... address=/run/containerd/containerd.sock May 13 23:41:45.145370 containerd[1870]: time="2025-05-13T23:41:45.143054287Z" level=info msg="containerd successfully booted in 0.570120s" May 13 23:41:45.143243 systemd[1]: Started containerd.service - containerd container runtime. May 13 23:41:45.186127 amazon-ssm-agent[2008]: 2025-05-13 23:41:44 INFO no_proxy: May 13 23:41:45.284179 amazon-ssm-agent[2008]: 2025-05-13 23:41:44 INFO Checking if agent identity type OnPrem can be assumed May 13 23:41:45.382454 amazon-ssm-agent[2008]: 2025-05-13 23:41:44 INFO Checking if agent identity type EC2 can be assumed May 13 23:41:45.481666 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO Agent will take identity from EC2 May 13 23:41:45.581179 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [amazon-ssm-agent] using named pipe channel for IPC May 13 23:41:45.657872 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [amazon-ssm-agent] using named pipe channel for IPC May 13 23:41:45.657872 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [amazon-ssm-agent] using named pipe channel for IPC May 13 23:41:45.657872 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 May 13 23:41:45.657872 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 May 13 23:41:45.657872 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [amazon-ssm-agent] Starting Core Agent May 13 23:41:45.658164 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [amazon-ssm-agent] registrar detected. Attempting registration May 13 23:41:45.658164 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [Registrar] Starting registrar module May 13 23:41:45.658164 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration May 13 23:41:45.658164 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [EC2Identity] EC2 registration was successful. May 13 23:41:45.658164 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [CredentialRefresher] credentialRefresher has started May 13 23:41:45.658164 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [CredentialRefresher] Starting credentials refresher loop May 13 23:41:45.658164 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO EC2RoleProvider Successfully connected with instance profile role credentials May 13 23:41:45.680346 amazon-ssm-agent[2008]: 2025-05-13 23:41:45 INFO [CredentialRefresher] Next credential rotation will be in 30.691657044766668 minutes May 13 23:41:46.443248 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 13 23:41:46.482565 sshd_keygen[1888]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 13 23:41:46.520783 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 13 23:41:46.527370 systemd[1]: Starting issuegen.service - Generate /run/issue... May 13 23:41:46.532626 systemd[1]: Started sshd@0-172.31.20.123:22-139.178.89.65:45688.service - OpenSSH per-connection server daemon (139.178.89.65:45688). May 13 23:41:46.559941 systemd[1]: issuegen.service: Deactivated successfully. May 13 23:41:46.560515 systemd[1]: Finished issuegen.service - Generate /run/issue. May 13 23:41:46.568510 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 13 23:41:46.598142 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 13 23:41:46.606971 systemd[1]: Started getty@tty1.service - Getty on tty1. May 13 23:41:46.614577 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. May 13 23:41:46.617056 systemd[1]: Reached target getty.target - Login Prompts. May 13 23:41:46.619671 systemd[1]: Reached target multi-user.target - Multi-User System. May 13 23:41:46.622159 systemd[1]: Startup finished in 1.081s (kernel) + 7.084s (initrd) + 7.803s (userspace) = 15.969s. May 13 23:41:46.686886 amazon-ssm-agent[2008]: 2025-05-13 23:41:46 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process May 13 23:41:46.787974 sshd[2083]: Accepted publickey for core from 139.178.89.65 port 45688 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:46.789712 amazon-ssm-agent[2008]: 2025-05-13 23:41:46 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2098) started May 13 23:41:46.790971 sshd-session[2083]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:46.817443 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 13 23:41:46.820676 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 13 23:41:46.831171 systemd-logind[1854]: New session 1 of user core. May 13 23:41:46.872211 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 13 23:41:46.878910 systemd[1]: Starting user@500.service - User Manager for UID 500... May 13 23:41:46.889492 amazon-ssm-agent[2008]: 2025-05-13 23:41:46 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds May 13 23:41:46.906881 (systemd)[2106]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 13 23:41:46.913593 systemd-logind[1854]: New session c1 of user core. May 13 23:41:46.957394 ntpd[1848]: Listen normally on 6 eth0 [fe80::4d5:99ff:fef1:5f1d%2]:123 May 13 23:41:46.957927 ntpd[1848]: 13 May 23:41:46 ntpd[1848]: Listen normally on 6 eth0 [fe80::4d5:99ff:fef1:5f1d%2]:123 May 13 23:41:47.219853 systemd[2106]: Queued start job for default target default.target. May 13 23:41:47.227706 systemd[2106]: Created slice app.slice - User Application Slice. May 13 23:41:47.227773 systemd[2106]: Reached target paths.target - Paths. May 13 23:41:47.228064 systemd[2106]: Reached target timers.target - Timers. May 13 23:41:47.230716 systemd[2106]: Starting dbus.socket - D-Bus User Message Bus Socket... May 13 23:41:47.262305 systemd[2106]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 13 23:41:47.262555 systemd[2106]: Reached target sockets.target - Sockets. May 13 23:41:47.262645 systemd[2106]: Reached target basic.target - Basic System. May 13 23:41:47.262730 systemd[2106]: Reached target default.target - Main User Target. May 13 23:41:47.262794 systemd[2106]: Startup finished in 332ms. May 13 23:41:47.262994 systemd[1]: Started user@500.service - User Manager for UID 500. May 13 23:41:47.274370 systemd[1]: Started session-1.scope - Session 1 of User core. May 13 23:41:47.427804 systemd[1]: Started sshd@1-172.31.20.123:22-139.178.89.65:45692.service - OpenSSH per-connection server daemon (139.178.89.65:45692). May 13 23:41:47.624618 sshd[2122]: Accepted publickey for core from 139.178.89.65 port 45692 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:47.626894 sshd-session[2122]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:47.635627 systemd-logind[1854]: New session 2 of user core. May 13 23:41:47.645378 systemd[1]: Started session-2.scope - Session 2 of User core. May 13 23:41:47.772522 sshd[2124]: Connection closed by 139.178.89.65 port 45692 May 13 23:41:47.771783 sshd-session[2122]: pam_unix(sshd:session): session closed for user core May 13 23:41:47.778404 systemd[1]: sshd@1-172.31.20.123:22-139.178.89.65:45692.service: Deactivated successfully. May 13 23:41:47.781586 systemd[1]: session-2.scope: Deactivated successfully. May 13 23:41:47.782739 systemd-logind[1854]: Session 2 logged out. Waiting for processes to exit. May 13 23:41:47.785014 systemd-logind[1854]: Removed session 2. May 13 23:41:47.808184 systemd[1]: Started sshd@2-172.31.20.123:22-139.178.89.65:45698.service - OpenSSH per-connection server daemon (139.178.89.65:45698). May 13 23:41:48.005349 sshd[2130]: Accepted publickey for core from 139.178.89.65 port 45698 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:48.007143 sshd-session[2130]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:48.015737 systemd-logind[1854]: New session 3 of user core. May 13 23:41:48.025383 systemd[1]: Started session-3.scope - Session 3 of User core. May 13 23:41:48.146576 sshd[2132]: Connection closed by 139.178.89.65 port 45698 May 13 23:41:48.145744 sshd-session[2130]: pam_unix(sshd:session): session closed for user core May 13 23:41:48.150935 systemd-logind[1854]: Session 3 logged out. Waiting for processes to exit. May 13 23:41:48.151910 systemd[1]: sshd@2-172.31.20.123:22-139.178.89.65:45698.service: Deactivated successfully. May 13 23:41:48.154928 systemd[1]: session-3.scope: Deactivated successfully. May 13 23:41:48.158771 systemd-logind[1854]: Removed session 3. May 13 23:41:48.186248 systemd[1]: Started sshd@3-172.31.20.123:22-139.178.89.65:45714.service - OpenSSH per-connection server daemon (139.178.89.65:45714). May 13 23:41:48.383208 sshd[2138]: Accepted publickey for core from 139.178.89.65 port 45714 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:48.385988 sshd-session[2138]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:48.394760 systemd-logind[1854]: New session 4 of user core. May 13 23:41:48.400373 systemd[1]: Started session-4.scope - Session 4 of User core. May 13 23:41:48.529619 sshd[2140]: Connection closed by 139.178.89.65 port 45714 May 13 23:41:48.528875 sshd-session[2138]: pam_unix(sshd:session): session closed for user core May 13 23:41:48.535929 systemd-logind[1854]: Session 4 logged out. Waiting for processes to exit. May 13 23:41:48.536778 systemd[1]: sshd@3-172.31.20.123:22-139.178.89.65:45714.service: Deactivated successfully. May 13 23:41:48.539978 systemd[1]: session-4.scope: Deactivated successfully. May 13 23:41:48.542023 systemd-logind[1854]: Removed session 4. May 13 23:41:48.565186 systemd[1]: Started sshd@4-172.31.20.123:22-139.178.89.65:45724.service - OpenSSH per-connection server daemon (139.178.89.65:45724). May 13 23:41:48.755816 sshd[2146]: Accepted publickey for core from 139.178.89.65 port 45724 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:48.758754 sshd-session[2146]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:48.769221 systemd-logind[1854]: New session 5 of user core. May 13 23:41:48.771376 systemd[1]: Started session-5.scope - Session 5 of User core. May 13 23:41:48.890029 sudo[2149]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 13 23:41:48.891247 sudo[2149]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 13 23:41:48.906866 sudo[2149]: pam_unix(sudo:session): session closed for user root May 13 23:41:48.929448 sshd[2148]: Connection closed by 139.178.89.65 port 45724 May 13 23:41:48.930502 sshd-session[2146]: pam_unix(sshd:session): session closed for user core May 13 23:41:48.936924 systemd-logind[1854]: Session 5 logged out. Waiting for processes to exit. May 13 23:41:48.937382 systemd[1]: sshd@4-172.31.20.123:22-139.178.89.65:45724.service: Deactivated successfully. May 13 23:41:48.940529 systemd[1]: session-5.scope: Deactivated successfully. May 13 23:41:48.945535 systemd-logind[1854]: Removed session 5. May 13 23:41:48.966563 systemd[1]: Started sshd@5-172.31.20.123:22-139.178.89.65:45740.service - OpenSSH per-connection server daemon (139.178.89.65:45740). May 13 23:41:49.165702 sshd[2155]: Accepted publickey for core from 139.178.89.65 port 45740 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:49.168060 sshd-session[2155]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:49.176975 systemd-logind[1854]: New session 6 of user core. May 13 23:41:49.182397 systemd[1]: Started session-6.scope - Session 6 of User core. May 13 23:41:49.286153 sudo[2159]: 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 May 13 23:41:49.286783 sudo[2159]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 13 23:41:49.293012 sudo[2159]: pam_unix(sudo:session): session closed for user root May 13 23:41:49.302823 sudo[2158]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 13 23:41:49.303469 sudo[2158]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 13 23:41:49.319551 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 13 23:41:49.381818 augenrules[2181]: No rules May 13 23:41:49.384426 systemd[1]: audit-rules.service: Deactivated successfully. May 13 23:41:49.384862 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 13 23:41:49.386962 sudo[2158]: pam_unix(sudo:session): session closed for user root May 13 23:41:49.410083 sshd[2157]: Connection closed by 139.178.89.65 port 45740 May 13 23:41:49.410907 sshd-session[2155]: pam_unix(sshd:session): session closed for user core May 13 23:41:49.418013 systemd[1]: sshd@5-172.31.20.123:22-139.178.89.65:45740.service: Deactivated successfully. May 13 23:41:49.421942 systemd[1]: session-6.scope: Deactivated successfully. May 13 23:41:49.423199 systemd-logind[1854]: Session 6 logged out. Waiting for processes to exit. May 13 23:41:49.424811 systemd-logind[1854]: Removed session 6. May 13 23:41:49.448797 systemd[1]: Started sshd@6-172.31.20.123:22-139.178.89.65:45750.service - OpenSSH per-connection server daemon (139.178.89.65:45750). May 13 23:41:49.639488 sshd[2190]: Accepted publickey for core from 139.178.89.65 port 45750 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:49.641944 sshd-session[2190]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:49.651638 systemd-logind[1854]: New session 7 of user core. May 13 23:41:49.657403 systemd[1]: Started session-7.scope - Session 7 of User core. May 13 23:41:49.761290 sudo[2193]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mkdir -p . May 13 23:41:49.762831 sudo[2193]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 13 23:41:49.768833 sudo[2193]: pam_unix(sudo:session): session closed for user root May 13 23:41:49.791737 sshd[2192]: Connection closed by 139.178.89.65 port 45750 May 13 23:41:49.792605 sshd-session[2190]: pam_unix(sshd:session): session closed for user core May 13 23:41:49.798556 systemd-logind[1854]: Session 7 logged out. Waiting for processes to exit. May 13 23:41:49.800125 systemd[1]: sshd@6-172.31.20.123:22-139.178.89.65:45750.service: Deactivated successfully. May 13 23:41:49.804383 systemd[1]: session-7.scope: Deactivated successfully. May 13 23:41:49.806483 systemd-logind[1854]: Removed session 7. May 13 23:41:49.829832 systemd[1]: Started sshd@7-172.31.20.123:22-139.178.89.65:45760.service - OpenSSH per-connection server daemon (139.178.89.65:45760). May 13 23:41:50.021293 sshd[2199]: Accepted publickey for core from 139.178.89.65 port 45760 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:50.023782 sshd-session[2199]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:50.034495 systemd-logind[1854]: New session 8 of user core. May 13 23:41:50.040378 systemd[1]: Started session-8.scope - Session 8 of User core. May 13 23:41:50.143163 sudo[2202]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/install -m 0755 /dev/stdin kolet May 13 23:41:50.144297 sudo[2202]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 13 23:41:50.908466 sudo[2202]: pam_unix(sudo:session): session closed for user root May 13 23:41:50.931322 sshd[2201]: Connection closed by 139.178.89.65 port 45760 May 13 23:41:50.932088 sshd-session[2199]: pam_unix(sshd:session): session closed for user core May 13 23:41:50.938139 systemd[1]: sshd@7-172.31.20.123:22-139.178.89.65:45760.service: Deactivated successfully. May 13 23:41:50.941402 systemd[1]: session-8.scope: Deactivated successfully. May 13 23:41:50.944069 systemd-logind[1854]: Session 8 logged out. Waiting for processes to exit. May 13 23:41:50.946096 systemd-logind[1854]: Removed session 8. May 13 23:41:51.230949 systemd-resolved[1659]: Clock change detected. Flushing caches. May 13 23:41:51.242617 systemd[1]: Started sshd@8-172.31.20.123:22-139.178.89.65:45776.service - OpenSSH per-connection server daemon (139.178.89.65:45776). May 13 23:41:51.436992 sshd[2208]: Accepted publickey for core from 139.178.89.65 port 45776 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:51.439622 sshd-session[2208]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:51.448059 systemd-logind[1854]: New session 9 of user core. May 13 23:41:51.457999 systemd[1]: Started session-9.scope - Session 9 of User core. May 13 23:41:51.627861 sshd[2210]: Connection closed by 139.178.89.65 port 45776 May 13 23:41:51.628651 sshd-session[2208]: pam_unix(sshd:session): session closed for user core May 13 23:41:51.634969 systemd[1]: sshd@8-172.31.20.123:22-139.178.89.65:45776.service: Deactivated successfully. May 13 23:41:51.638420 systemd[1]: session-9.scope: Deactivated successfully. May 13 23:41:51.640027 systemd-logind[1854]: Session 9 logged out. Waiting for processes to exit. May 13 23:41:51.642069 systemd-logind[1854]: Removed session 9. May 13 23:41:51.664790 systemd[1]: Started sshd@9-172.31.20.123:22-139.178.89.65:45786.service - OpenSSH per-connection server daemon (139.178.89.65:45786). May 13 23:41:51.860210 sshd[2223]: Accepted publickey for core from 139.178.89.65 port 45786 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:51.862664 sshd-session[2223]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:51.873803 systemd-logind[1854]: New session 10 of user core. May 13 23:41:51.880049 systemd[1]: Started session-10.scope - Session 10 of User core. May 13 23:41:52.180151 systemd[1]: Starting docker.service - Docker Application Container Engine... May 13 23:41:52.195236 (dockerd)[2239]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU May 13 23:41:52.541026 dockerd[2239]: time="2025-05-13T23:41:52.540091878Z" level=info msg="Starting up" May 13 23:41:52.543696 dockerd[2239]: time="2025-05-13T23:41:52.543585894Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 13 23:41:52.693539 dockerd[2239]: time="2025-05-13T23:41:52.693465151Z" level=info msg="Loading containers: start." May 13 23:41:52.941914 kernel: Initializing XFRM netlink socket May 13 23:41:52.945967 (udev-worker)[2264]: Network interface NamePolicy= disabled on kernel command line. May 13 23:41:53.065182 systemd-networkd[1711]: docker0: Link UP May 13 23:41:53.146068 dockerd[2239]: time="2025-05-13T23:41:53.145997381Z" level=info msg="Loading containers: done." May 13 23:41:53.175298 dockerd[2239]: time="2025-05-13T23:41:53.175222661Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 May 13 23:41:53.175522 dockerd[2239]: time="2025-05-13T23:41:53.175358549Z" level=info msg="Docker daemon" commit=c710b88579fcb5e0d53f96dcae976d79323b9166 containerd-snapshotter=false storage-driver=overlay2 version=27.4.1 May 13 23:41:53.175614 dockerd[2239]: time="2025-05-13T23:41:53.175576373Z" level=info msg="Daemon has completed initialization" May 13 23:41:53.227793 dockerd[2239]: time="2025-05-13T23:41:53.227598437Z" level=info msg="API listen on /run/docker.sock" May 13 23:41:53.228157 systemd[1]: Started docker.service - Docker Application Container Engine. May 13 23:41:54.327621 kernel: docker0: port 1(vethb1c6247) entered blocking state May 13 23:41:54.327819 kernel: docker0: port 1(vethb1c6247) entered disabled state May 13 23:41:54.329815 kernel: vethb1c6247: entered allmulticast mode May 13 23:41:54.329880 kernel: vethb1c6247: entered promiscuous mode May 13 23:41:54.331397 (udev-worker)[2350]: Network interface NamePolicy= disabled on kernel command line. May 13 23:41:54.333908 systemd-networkd[1711]: vethb1c6247: Link UP May 13 23:41:54.404032 containerd[1870]: time="2025-05-13T23:41:54.403965859Z" level=info msg="connecting to shim 95b0bb216269cf605d1f45a7ddc17534ff253b01c5a1309b946558822f6f79c3" address="unix:///run/containerd/s/5606f96b3b0c4b0b75f619e7b6368c204977ee81849f27e368d2ac2f4d7cb3bb" namespace=moby protocol=ttrpc version=3 May 13 23:41:54.441990 systemd[1]: Started docker-95b0bb216269cf605d1f45a7ddc17534ff253b01c5a1309b946558822f6f79c3.scope - libcontainer container 95b0bb216269cf605d1f45a7ddc17534ff253b01c5a1309b946558822f6f79c3. May 13 23:41:54.529768 kernel: eth0: renamed from vethe55b610 May 13 23:41:54.538336 kernel: docker0: port 1(vethb1c6247) entered blocking state May 13 23:41:54.538447 kernel: docker0: port 1(vethb1c6247) entered forwarding state May 13 23:41:54.538418 systemd-networkd[1711]: vethb1c6247: Gained carrier May 13 23:41:54.539122 systemd-networkd[1711]: docker0: Gained carrier May 13 23:41:55.790019 systemd-networkd[1711]: docker0: Gained IPv6LL May 13 23:41:56.365941 systemd-networkd[1711]: vethb1c6247: Gained IPv6LL May 13 23:41:57.635782 systemd[1]: docker-95b0bb216269cf605d1f45a7ddc17534ff253b01c5a1309b946558822f6f79c3.scope: Deactivated successfully. May 13 23:41:57.662410 dockerd[2239]: time="2025-05-13T23:41:57.662325923Z" level=info msg="ignoring event" container=95b0bb216269cf605d1f45a7ddc17534ff253b01c5a1309b946558822f6f79c3 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 13 23:41:57.664012 containerd[1870]: time="2025-05-13T23:41:57.663360335Z" level=info msg="shim disconnected" id=95b0bb216269cf605d1f45a7ddc17534ff253b01c5a1309b946558822f6f79c3 namespace=moby May 13 23:41:57.664012 containerd[1870]: time="2025-05-13T23:41:57.663430847Z" level=warning msg="cleaning up after shim disconnected" id=95b0bb216269cf605d1f45a7ddc17534ff253b01c5a1309b946558822f6f79c3 namespace=moby May 13 23:41:57.664012 containerd[1870]: time="2025-05-13T23:41:57.663451679Z" level=info msg="cleaning up dead shim" namespace=moby May 13 23:41:57.693748 kernel: vethe55b610: renamed from eth0 May 13 23:41:57.703383 systemd-networkd[1711]: vethb1c6247: Lost carrier May 13 23:41:57.703893 kernel: docker0: port 1(vethb1c6247) entered disabled state May 13 23:41:57.719322 kernel: docker0: port 1(vethb1c6247) entered disabled state May 13 23:41:57.717571 systemd-networkd[1711]: vethb1c6247: Link DOWN May 13 23:41:57.722293 kernel: vethb1c6247 (unregistering): left allmulticast mode May 13 23:41:57.722396 kernel: vethb1c6247 (unregistering): left promiscuous mode May 13 23:41:57.723710 kernel: docker0: port 1(vethb1c6247) entered disabled state May 13 23:41:57.744252 systemd[1]: run-docker-netns-14812ae5c2ca.mount: Deactivated successfully. May 13 23:41:57.749015 systemd[1]: var-lib-docker-overlay2-ad6bc19ab4c1975ad9ff250adf9f1de7907e53f0504d43b82cc02add08eadc00-merged.mount: Deactivated successfully. May 13 23:41:57.790763 sshd[2225]: Connection closed by 139.178.89.65 port 45786 May 13 23:41:57.790488 sshd-session[2223]: pam_unix(sshd:session): session closed for user core May 13 23:41:57.797245 systemd[1]: sshd@9-172.31.20.123:22-139.178.89.65:45786.service: Deactivated successfully. May 13 23:41:57.807616 systemd[1]: session-10.scope: Deactivated successfully. May 13 23:41:57.809265 systemd-logind[1854]: Session 10 logged out. Waiting for processes to exit. May 13 23:41:57.811044 systemd-logind[1854]: Removed session 10. May 13 23:41:57.830897 systemd[1]: Started sshd@10-172.31.20.123:22-139.178.89.65:55460.service - OpenSSH per-connection server daemon (139.178.89.65:55460). May 13 23:41:58.021662 sshd[2525]: Accepted publickey for core from 139.178.89.65 port 55460 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:58.024773 sshd-session[2525]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:58.035832 systemd-logind[1854]: New session 11 of user core. May 13 23:41:58.043025 systemd[1]: Started session-11.scope - Session 11 of User core. May 13 23:41:58.219501 systemd[1]: var-lib-docker-overlay2-0a2e7e000bf18fe28cdc6236f0f5a15b827688fd4a70a560a02c2e4e0296eaf7\x2dinit-merged.mount: Deactivated successfully. May 13 23:41:58.255533 (udev-worker)[2513]: Network interface NamePolicy= disabled on kernel command line. May 13 23:41:58.259062 kernel: docker0: port 1(veth43ccf26) entered blocking state May 13 23:41:58.259133 kernel: docker0: port 1(veth43ccf26) entered disabled state May 13 23:41:58.260874 kernel: veth43ccf26: entered allmulticast mode May 13 23:41:58.262416 kernel: veth43ccf26: entered promiscuous mode May 13 23:41:58.263332 (udev-worker)[2520]: Network interface NamePolicy= disabled on kernel command line. May 13 23:41:58.267259 kernel: docker0: port 1(veth43ccf26) entered blocking state May 13 23:41:58.267359 kernel: docker0: port 1(veth43ccf26) entered forwarding state May 13 23:41:58.266698 systemd-networkd[1711]: veth43ccf26: Link UP May 13 23:41:58.315558 containerd[1870]: time="2025-05-13T23:41:58.315380003Z" level=info msg="connecting to shim 2eda33d232251051fe1626217c03dd025871e65fece0a8537f9944e80b561a03" address="unix:///run/containerd/s/067a28be22db7b96f22cafc746eb1037cb414d0a11f45e9bcf2293f52a00a0d0" namespace=moby protocol=ttrpc version=3 May 13 23:41:58.351989 systemd[1]: Started docker-2eda33d232251051fe1626217c03dd025871e65fece0a8537f9944e80b561a03.scope - libcontainer container 2eda33d232251051fe1626217c03dd025871e65fece0a8537f9944e80b561a03. May 13 23:41:58.437054 kernel: eth0: renamed from veth4d8ac00 May 13 23:41:58.443762 systemd-networkd[1711]: veth43ccf26: Gained carrier May 13 23:41:58.495402 systemd[1]: docker-2eda33d232251051fe1626217c03dd025871e65fece0a8537f9944e80b561a03.scope: Deactivated successfully. May 13 23:41:58.525291 dockerd[2239]: time="2025-05-13T23:41:58.524389500Z" level=info msg="ignoring event" container=2eda33d232251051fe1626217c03dd025871e65fece0a8537f9944e80b561a03 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 13 23:41:58.525614 containerd[1870]: time="2025-05-13T23:41:58.525555636Z" level=info msg="shim disconnected" id=2eda33d232251051fe1626217c03dd025871e65fece0a8537f9944e80b561a03 namespace=moby May 13 23:41:58.525759 containerd[1870]: time="2025-05-13T23:41:58.525713124Z" level=warning msg="cleaning up after shim disconnected" id=2eda33d232251051fe1626217c03dd025871e65fece0a8537f9944e80b561a03 namespace=moby May 13 23:41:58.525918 containerd[1870]: time="2025-05-13T23:41:58.525851640Z" level=error msg="failed sending message on channel" error="write unix /run/containerd/containerd.sock.ttrpc->@: write: broken pipe" May 13 23:41:58.525998 containerd[1870]: time="2025-05-13T23:41:58.525863472Z" level=info msg="cleaning up dead shim" namespace=moby May 13 23:41:58.553951 systemd-networkd[1711]: veth43ccf26: Lost carrier May 13 23:41:58.554767 kernel: docker0: port 1(veth43ccf26) entered disabled state May 13 23:41:58.556743 kernel: veth4d8ac00: renamed from eth0 May 13 23:41:58.568825 (udev-worker)[2547]: Network interface NamePolicy= disabled on kernel command line. May 13 23:41:58.575319 kernel: docker0: port 1(veth43ccf26) entered disabled state May 13 23:41:58.575424 kernel: veth43ccf26 (unregistering): left allmulticast mode May 13 23:41:58.573568 systemd-networkd[1711]: veth43ccf26: Link DOWN May 13 23:41:58.576766 kernel: veth43ccf26 (unregistering): left promiscuous mode May 13 23:41:58.578275 kernel: docker0: port 1(veth43ccf26) entered disabled state May 13 23:41:58.630914 sshd[2527]: Connection closed by 139.178.89.65 port 55460 May 13 23:41:58.632136 sshd-session[2525]: pam_unix(sshd:session): session closed for user core May 13 23:41:58.637308 systemd[1]: sshd@10-172.31.20.123:22-139.178.89.65:55460.service: Deactivated successfully. May 13 23:41:58.640690 systemd[1]: session-11.scope: Deactivated successfully. May 13 23:41:58.643843 systemd-logind[1854]: Session 11 logged out. Waiting for processes to exit. May 13 23:41:58.645539 systemd-logind[1854]: Removed session 11. May 13 23:41:58.670910 systemd[1]: Started sshd@11-172.31.20.123:22-139.178.89.65:55474.service - OpenSSH per-connection server daemon (139.178.89.65:55474). May 13 23:41:58.710173 systemd-networkd[1711]: docker0: Lost carrier May 13 23:41:58.862302 sshd[2631]: Accepted publickey for core from 139.178.89.65 port 55474 ssh2: RSA SHA256:xZnWmgdZViEQ6G9tYEzm7AmOSvmGFHk0KXIslK9RHvo May 13 23:41:58.864301 sshd-session[2631]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 23:41:58.873396 systemd-logind[1854]: New session 12 of user core. May 13 23:41:58.880983 systemd[1]: Started session-12.scope - Session 12 of User core. May 13 23:41:59.021240 ntpdate[2641]: ntpdate 4.2.8p17@1.4004-o Tue May 13 21:33:16 UTC 2025 (1) May 13 23:42:05.790945 ntpdate[2641]: adjust time server 137.110.222.27 offset -0.000287 sec May 13 23:42:05.814815 sshd[2633]: Connection closed by 139.178.89.65 port 55474 May 13 23:42:05.815693 sshd-session[2631]: pam_unix(sshd:session): session closed for user core May 13 23:42:05.822330 systemd-logind[1854]: Session 12 logged out. Waiting for processes to exit. May 13 23:42:05.823782 systemd[1]: sshd@11-172.31.20.123:22-139.178.89.65:55474.service: Deactivated successfully. May 13 23:42:05.826773 systemd[1]: session-12.scope: Deactivated successfully. May 13 23:42:05.829462 systemd-logind[1854]: Removed session 12.