Apr 29 23:56:11.216308 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Apr 29 23:56:11.216355 kernel: Linux version 6.6.88-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Tue Apr 29 22:24:03 -00 2025 Apr 29 23:56:11.216379 kernel: KASLR disabled due to lack of seed Apr 29 23:56:11.216396 kernel: efi: EFI v2.7 by EDK II Apr 29 23:56:11.216411 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b003a98 MEMRESERVE=0x78503d98 Apr 29 23:56:11.216426 kernel: secureboot: Secure boot disabled Apr 29 23:56:11.216444 kernel: ACPI: Early table checksum verification disabled Apr 29 23:56:11.216459 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Apr 29 23:56:11.216474 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Apr 29 23:56:11.216489 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Apr 29 23:56:11.216509 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Apr 29 23:56:11.216525 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Apr 29 23:56:11.216540 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Apr 29 23:56:11.216555 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Apr 29 23:56:11.216573 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Apr 29 23:56:11.216593 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Apr 29 23:56:11.216610 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Apr 29 23:56:11.216626 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Apr 29 23:56:11.216642 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Apr 29 23:56:11.216658 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Apr 29 23:56:11.216674 kernel: printk: bootconsole [uart0] enabled Apr 29 23:56:11.216690 kernel: NUMA: Failed to initialise from firmware Apr 29 23:56:11.216707 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Apr 29 23:56:11.216723 kernel: NUMA: NODE_DATA [mem 0x4b5840800-0x4b5845fff] Apr 29 23:56:11.216739 kernel: Zone ranges: Apr 29 23:56:11.216755 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Apr 29 23:56:11.216775 kernel: DMA32 empty Apr 29 23:56:11.216791 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Apr 29 23:56:11.216807 kernel: Movable zone start for each node Apr 29 23:56:11.216823 kernel: Early memory node ranges Apr 29 23:56:11.216839 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Apr 29 23:56:11.216855 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Apr 29 23:56:11.216871 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Apr 29 23:56:11.216887 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Apr 29 23:56:11.216903 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Apr 29 23:56:11.216919 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Apr 29 23:56:11.216935 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Apr 29 23:56:11.216950 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Apr 29 23:56:11.217014 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Apr 29 23:56:11.217036 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Apr 29 23:56:11.217062 kernel: psci: probing for conduit method from ACPI. Apr 29 23:56:11.217080 kernel: psci: PSCIv1.0 detected in firmware. Apr 29 23:56:11.217098 kernel: psci: Using standard PSCI v0.2 function IDs Apr 29 23:56:11.217120 kernel: psci: Trusted OS migration not required Apr 29 23:56:11.217138 kernel: psci: SMC Calling Convention v1.1 Apr 29 23:56:11.217155 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Apr 29 23:56:11.217172 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Apr 29 23:56:11.217189 kernel: pcpu-alloc: [0] 0 [0] 1 Apr 29 23:56:11.217207 kernel: Detected PIPT I-cache on CPU0 Apr 29 23:56:11.217224 kernel: CPU features: detected: GIC system register CPU interface Apr 29 23:56:11.217241 kernel: CPU features: detected: Spectre-v2 Apr 29 23:56:11.217258 kernel: CPU features: detected: Spectre-v3a Apr 29 23:56:11.217275 kernel: CPU features: detected: Spectre-BHB Apr 29 23:56:11.217292 kernel: CPU features: detected: ARM erratum 1742098 Apr 29 23:56:11.217309 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Apr 29 23:56:11.217331 kernel: alternatives: applying boot alternatives Apr 29 23:56:11.217351 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=6e9bced8073e517a5f5178e5412663c3084f53d67852b3dfe0380ce71e6d0edd Apr 29 23:56:11.217369 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Apr 29 23:56:11.217386 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 29 23:56:11.217403 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 29 23:56:11.217420 kernel: Fallback order for Node 0: 0 Apr 29 23:56:11.217437 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Apr 29 23:56:11.217454 kernel: Policy zone: Normal Apr 29 23:56:11.217470 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 29 23:56:11.217488 kernel: software IO TLB: area num 2. Apr 29 23:56:11.217510 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Apr 29 23:56:11.217527 kernel: Memory: 3819836K/4030464K available (10304K kernel code, 2186K rwdata, 8104K rodata, 39744K init, 897K bss, 210628K reserved, 0K cma-reserved) Apr 29 23:56:11.217545 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Apr 29 23:56:11.217562 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 29 23:56:11.217579 kernel: rcu: RCU event tracing is enabled. Apr 29 23:56:11.217597 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Apr 29 23:56:11.217614 kernel: Trampoline variant of Tasks RCU enabled. Apr 29 23:56:11.217631 kernel: Tracing variant of Tasks RCU enabled. Apr 29 23:56:11.217648 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 29 23:56:11.217665 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Apr 29 23:56:11.217682 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Apr 29 23:56:11.217703 kernel: GICv3: 96 SPIs implemented Apr 29 23:56:11.217720 kernel: GICv3: 0 Extended SPIs implemented Apr 29 23:56:11.217737 kernel: Root IRQ handler: gic_handle_irq Apr 29 23:56:11.217753 kernel: GICv3: GICv3 features: 16 PPIs Apr 29 23:56:11.217770 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Apr 29 23:56:11.217786 kernel: ITS [mem 0x10080000-0x1009ffff] Apr 29 23:56:11.217803 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Apr 29 23:56:11.217820 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Apr 29 23:56:11.217837 kernel: GICv3: using LPI property table @0x00000004000d0000 Apr 29 23:56:11.217854 kernel: ITS: Using hypervisor restricted LPI range [128] Apr 29 23:56:11.217872 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Apr 29 23:56:11.217888 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 29 23:56:11.217910 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Apr 29 23:56:11.217927 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Apr 29 23:56:11.217944 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Apr 29 23:56:11.217961 kernel: Console: colour dummy device 80x25 Apr 29 23:56:11.222260 kernel: printk: console [tty1] enabled Apr 29 23:56:11.222315 kernel: ACPI: Core revision 20230628 Apr 29 23:56:11.222338 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Apr 29 23:56:11.222361 kernel: pid_max: default: 32768 minimum: 301 Apr 29 23:56:11.222385 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Apr 29 23:56:11.222404 kernel: landlock: Up and running. Apr 29 23:56:11.222437 kernel: SELinux: Initializing. Apr 29 23:56:11.222455 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 29 23:56:11.222472 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 29 23:56:11.222489 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Apr 29 23:56:11.222507 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Apr 29 23:56:11.222524 kernel: rcu: Hierarchical SRCU implementation. Apr 29 23:56:11.222543 kernel: rcu: Max phase no-delay instances is 400. Apr 29 23:56:11.222560 kernel: Platform MSI: ITS@0x10080000 domain created Apr 29 23:56:11.222583 kernel: PCI/MSI: ITS@0x10080000 domain created Apr 29 23:56:11.222600 kernel: Remapping and enabling EFI services. Apr 29 23:56:11.222618 kernel: smp: Bringing up secondary CPUs ... Apr 29 23:56:11.222635 kernel: Detected PIPT I-cache on CPU1 Apr 29 23:56:11.222653 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Apr 29 23:56:11.222670 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Apr 29 23:56:11.222688 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Apr 29 23:56:11.222706 kernel: smp: Brought up 1 node, 2 CPUs Apr 29 23:56:11.222723 kernel: SMP: Total of 2 processors activated. Apr 29 23:56:11.222740 kernel: CPU features: detected: 32-bit EL0 Support Apr 29 23:56:11.222762 kernel: CPU features: detected: 32-bit EL1 Support Apr 29 23:56:11.222780 kernel: CPU features: detected: CRC32 instructions Apr 29 23:56:11.222808 kernel: CPU: All CPU(s) started at EL1 Apr 29 23:56:11.222830 kernel: alternatives: applying system-wide alternatives Apr 29 23:56:11.222848 kernel: devtmpfs: initialized Apr 29 23:56:11.222866 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 29 23:56:11.222884 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Apr 29 23:56:11.222902 kernel: pinctrl core: initialized pinctrl subsystem Apr 29 23:56:11.222920 kernel: SMBIOS 3.0.0 present. Apr 29 23:56:11.222942 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Apr 29 23:56:11.222961 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 29 23:56:11.225294 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Apr 29 23:56:11.225320 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Apr 29 23:56:11.225344 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Apr 29 23:56:11.225364 kernel: audit: initializing netlink subsys (disabled) Apr 29 23:56:11.225383 kernel: audit: type=2000 audit(0.220:1): state=initialized audit_enabled=0 res=1 Apr 29 23:56:11.225410 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 29 23:56:11.225429 kernel: cpuidle: using governor menu Apr 29 23:56:11.225448 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Apr 29 23:56:11.225466 kernel: ASID allocator initialised with 65536 entries Apr 29 23:56:11.225484 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 29 23:56:11.225502 kernel: Serial: AMBA PL011 UART driver Apr 29 23:56:11.225520 kernel: Modules: 17408 pages in range for non-PLT usage Apr 29 23:56:11.225537 kernel: Modules: 508928 pages in range for PLT usage Apr 29 23:56:11.225556 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 29 23:56:11.225579 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Apr 29 23:56:11.225597 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Apr 29 23:56:11.225615 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Apr 29 23:56:11.225633 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 29 23:56:11.225651 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Apr 29 23:56:11.225669 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Apr 29 23:56:11.225686 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Apr 29 23:56:11.225704 kernel: ACPI: Added _OSI(Module Device) Apr 29 23:56:11.225722 kernel: ACPI: Added _OSI(Processor Device) Apr 29 23:56:11.225744 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Apr 29 23:56:11.225762 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 29 23:56:11.225780 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 29 23:56:11.225798 kernel: ACPI: Interpreter enabled Apr 29 23:56:11.225816 kernel: ACPI: Using GIC for interrupt routing Apr 29 23:56:11.225834 kernel: ACPI: MCFG table detected, 1 entries Apr 29 23:56:11.225852 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Apr 29 23:56:11.226241 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 29 23:56:11.226456 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Apr 29 23:56:11.226656 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Apr 29 23:56:11.226853 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Apr 29 23:56:11.228533 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Apr 29 23:56:11.228578 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Apr 29 23:56:11.228598 kernel: acpiphp: Slot [1] registered Apr 29 23:56:11.228616 kernel: acpiphp: Slot [2] registered Apr 29 23:56:11.228635 kernel: acpiphp: Slot [3] registered Apr 29 23:56:11.228663 kernel: acpiphp: Slot [4] registered Apr 29 23:56:11.228682 kernel: acpiphp: Slot [5] registered Apr 29 23:56:11.228721 kernel: acpiphp: Slot [6] registered Apr 29 23:56:11.228740 kernel: acpiphp: Slot [7] registered Apr 29 23:56:11.228760 kernel: acpiphp: Slot [8] registered Apr 29 23:56:11.228778 kernel: acpiphp: Slot [9] registered Apr 29 23:56:11.228796 kernel: acpiphp: Slot [10] registered Apr 29 23:56:11.228816 kernel: acpiphp: Slot [11] registered Apr 29 23:56:11.228834 kernel: acpiphp: Slot [12] registered Apr 29 23:56:11.228852 kernel: acpiphp: Slot [13] registered Apr 29 23:56:11.228877 kernel: acpiphp: Slot [14] registered Apr 29 23:56:11.228895 kernel: acpiphp: Slot [15] registered Apr 29 23:56:11.228913 kernel: acpiphp: Slot [16] registered Apr 29 23:56:11.228931 kernel: acpiphp: Slot [17] registered Apr 29 23:56:11.228949 kernel: acpiphp: Slot [18] registered Apr 29 23:56:11.228966 kernel: acpiphp: Slot [19] registered Apr 29 23:56:11.229044 kernel: acpiphp: Slot [20] registered Apr 29 23:56:11.229063 kernel: acpiphp: Slot [21] registered Apr 29 23:56:11.229081 kernel: acpiphp: Slot [22] registered Apr 29 23:56:11.229105 kernel: acpiphp: Slot [23] registered Apr 29 23:56:11.229124 kernel: acpiphp: Slot [24] registered Apr 29 23:56:11.229142 kernel: acpiphp: Slot [25] registered Apr 29 23:56:11.229160 kernel: acpiphp: Slot [26] registered Apr 29 23:56:11.229178 kernel: acpiphp: Slot [27] registered Apr 29 23:56:11.229196 kernel: acpiphp: Slot [28] registered Apr 29 23:56:11.229214 kernel: acpiphp: Slot [29] registered Apr 29 23:56:11.229233 kernel: acpiphp: Slot [30] registered Apr 29 23:56:11.229251 kernel: acpiphp: Slot [31] registered Apr 29 23:56:11.229269 kernel: PCI host bridge to bus 0000:00 Apr 29 23:56:11.229518 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Apr 29 23:56:11.229705 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Apr 29 23:56:11.229894 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Apr 29 23:56:11.230180 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Apr 29 23:56:11.230431 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Apr 29 23:56:11.230667 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Apr 29 23:56:11.230888 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Apr 29 23:56:11.231226 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Apr 29 23:56:11.231442 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Apr 29 23:56:11.231651 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Apr 29 23:56:11.231875 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Apr 29 23:56:11.232237 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Apr 29 23:56:11.232444 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Apr 29 23:56:11.232658 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Apr 29 23:56:11.232863 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Apr 29 23:56:11.233118 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Apr 29 23:56:11.233343 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Apr 29 23:56:11.233573 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Apr 29 23:56:11.233785 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Apr 29 23:56:11.236459 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Apr 29 23:56:11.236730 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Apr 29 23:56:11.236916 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Apr 29 23:56:11.237167 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Apr 29 23:56:11.237196 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Apr 29 23:56:11.237216 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Apr 29 23:56:11.237234 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Apr 29 23:56:11.237253 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Apr 29 23:56:11.237272 kernel: iommu: Default domain type: Translated Apr 29 23:56:11.237299 kernel: iommu: DMA domain TLB invalidation policy: strict mode Apr 29 23:56:11.237317 kernel: efivars: Registered efivars operations Apr 29 23:56:11.237336 kernel: vgaarb: loaded Apr 29 23:56:11.237355 kernel: clocksource: Switched to clocksource arch_sys_counter Apr 29 23:56:11.237374 kernel: VFS: Disk quotas dquot_6.6.0 Apr 29 23:56:11.237392 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 29 23:56:11.237410 kernel: pnp: PnP ACPI init Apr 29 23:56:11.237650 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Apr 29 23:56:11.237684 kernel: pnp: PnP ACPI: found 1 devices Apr 29 23:56:11.237703 kernel: NET: Registered PF_INET protocol family Apr 29 23:56:11.237722 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 29 23:56:11.237740 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Apr 29 23:56:11.237759 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 29 23:56:11.237777 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Apr 29 23:56:11.237796 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Apr 29 23:56:11.237815 kernel: TCP: Hash tables configured (established 32768 bind 32768) Apr 29 23:56:11.237833 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 29 23:56:11.237856 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 29 23:56:11.237875 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 29 23:56:11.237892 kernel: PCI: CLS 0 bytes, default 64 Apr 29 23:56:11.237911 kernel: kvm [1]: HYP mode not available Apr 29 23:56:11.237930 kernel: Initialise system trusted keyrings Apr 29 23:56:11.237948 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Apr 29 23:56:11.237966 kernel: Key type asymmetric registered Apr 29 23:56:11.238091 kernel: Asymmetric key parser 'x509' registered Apr 29 23:56:11.238111 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Apr 29 23:56:11.238139 kernel: io scheduler mq-deadline registered Apr 29 23:56:11.238158 kernel: io scheduler kyber registered Apr 29 23:56:11.238176 kernel: io scheduler bfq registered Apr 29 23:56:11.238411 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Apr 29 23:56:11.238442 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Apr 29 23:56:11.238461 kernel: ACPI: button: Power Button [PWRB] Apr 29 23:56:11.238480 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Apr 29 23:56:11.238498 kernel: ACPI: button: Sleep Button [SLPB] Apr 29 23:56:11.238586 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 29 23:56:11.238609 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Apr 29 23:56:11.240857 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Apr 29 23:56:11.240901 kernel: printk: console [ttyS0] disabled Apr 29 23:56:11.240920 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Apr 29 23:56:11.240939 kernel: printk: console [ttyS0] enabled Apr 29 23:56:11.240958 kernel: printk: bootconsole [uart0] disabled Apr 29 23:56:11.240998 kernel: thunder_xcv, ver 1.0 Apr 29 23:56:11.241019 kernel: thunder_bgx, ver 1.0 Apr 29 23:56:11.241037 kernel: nicpf, ver 1.0 Apr 29 23:56:11.241065 kernel: nicvf, ver 1.0 Apr 29 23:56:11.241290 kernel: rtc-efi rtc-efi.0: registered as rtc0 Apr 29 23:56:11.241480 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-04-29T23:56:10 UTC (1745970970) Apr 29 23:56:11.241506 kernel: hid: raw HID events driver (C) Jiri Kosina Apr 29 23:56:11.241524 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Apr 29 23:56:11.241543 kernel: watchdog: Delayed init of the lockup detector failed: -19 Apr 29 23:56:11.241561 kernel: watchdog: Hard watchdog permanently disabled Apr 29 23:56:11.241585 kernel: NET: Registered PF_INET6 protocol family Apr 29 23:56:11.241603 kernel: Segment Routing with IPv6 Apr 29 23:56:11.241621 kernel: In-situ OAM (IOAM) with IPv6 Apr 29 23:56:11.241639 kernel: NET: Registered PF_PACKET protocol family Apr 29 23:56:11.241656 kernel: Key type dns_resolver registered Apr 29 23:56:11.241674 kernel: registered taskstats version 1 Apr 29 23:56:11.241693 kernel: Loading compiled-in X.509 certificates Apr 29 23:56:11.241711 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.88-flatcar: bbef389676bd9584646af24e9e264c7789f8630f' Apr 29 23:56:11.241729 kernel: Key type .fscrypt registered Apr 29 23:56:11.241747 kernel: Key type fscrypt-provisioning registered Apr 29 23:56:11.241769 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 29 23:56:11.241787 kernel: ima: Allocated hash algorithm: sha1 Apr 29 23:56:11.241805 kernel: ima: No architecture policies found Apr 29 23:56:11.241823 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Apr 29 23:56:11.241841 kernel: clk: Disabling unused clocks Apr 29 23:56:11.241859 kernel: Freeing unused kernel memory: 39744K Apr 29 23:56:11.241876 kernel: Run /init as init process Apr 29 23:56:11.241894 kernel: with arguments: Apr 29 23:56:11.241912 kernel: /init Apr 29 23:56:11.241934 kernel: with environment: Apr 29 23:56:11.241951 kernel: HOME=/ Apr 29 23:56:11.241997 kernel: TERM=linux Apr 29 23:56:11.242020 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Apr 29 23:56:11.242043 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Apr 29 23:56:11.242082 systemd[1]: Detected virtualization amazon. Apr 29 23:56:11.242104 systemd[1]: Detected architecture arm64. Apr 29 23:56:11.242129 systemd[1]: Running in initrd. Apr 29 23:56:11.242148 systemd[1]: No hostname configured, using default hostname. Apr 29 23:56:11.242167 systemd[1]: Hostname set to . Apr 29 23:56:11.242187 systemd[1]: Initializing machine ID from VM UUID. Apr 29 23:56:11.242206 systemd[1]: Queued start job for default target initrd.target. Apr 29 23:56:11.242225 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 29 23:56:11.242245 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 29 23:56:11.242265 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 29 23:56:11.242290 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 29 23:56:11.242310 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 29 23:56:11.242330 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 29 23:56:11.242352 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Apr 29 23:56:11.242373 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Apr 29 23:56:11.242392 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 29 23:56:11.242412 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 29 23:56:11.242436 systemd[1]: Reached target paths.target - Path Units. Apr 29 23:56:11.242456 systemd[1]: Reached target slices.target - Slice Units. Apr 29 23:56:11.242475 systemd[1]: Reached target swap.target - Swaps. Apr 29 23:56:11.242494 systemd[1]: Reached target timers.target - Timer Units. Apr 29 23:56:11.242514 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 29 23:56:11.242533 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 29 23:56:11.242552 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 29 23:56:11.242572 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Apr 29 23:56:11.242591 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 29 23:56:11.242616 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 29 23:56:11.242636 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 29 23:56:11.242656 systemd[1]: Reached target sockets.target - Socket Units. Apr 29 23:56:11.242675 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 29 23:56:11.242694 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 29 23:56:11.242715 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 29 23:56:11.242734 systemd[1]: Starting systemd-fsck-usr.service... Apr 29 23:56:11.242753 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 29 23:56:11.242778 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 29 23:56:11.242797 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:56:11.242817 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 29 23:56:11.242836 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 29 23:56:11.242856 systemd[1]: Finished systemd-fsck-usr.service. Apr 29 23:56:11.242877 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 29 23:56:11.242938 systemd-journald[252]: Collecting audit messages is disabled. Apr 29 23:56:11.243000 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:56:11.243023 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 29 23:56:11.243049 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Apr 29 23:56:11.243068 kernel: Bridge firewalling registered Apr 29 23:56:11.243087 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 29 23:56:11.243107 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 29 23:56:11.243127 systemd-journald[252]: Journal started Apr 29 23:56:11.243164 systemd-journald[252]: Runtime Journal (/run/log/journal/ec24895954ed57d00ed0fdc63925a521) is 8.0M, max 75.3M, 67.3M free. Apr 29 23:56:11.190021 systemd-modules-load[253]: Inserted module 'overlay' Apr 29 23:56:11.251101 systemd[1]: Started systemd-journald.service - Journal Service. Apr 29 23:56:11.228759 systemd-modules-load[253]: Inserted module 'br_netfilter' Apr 29 23:56:11.255039 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 29 23:56:11.263270 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 29 23:56:11.274296 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 29 23:56:11.310502 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 29 23:56:11.315916 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:56:11.328275 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 29 23:56:11.343154 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 29 23:56:11.356034 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 29 23:56:11.372315 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 29 23:56:11.392146 dracut-cmdline[285]: dracut-dracut-053 Apr 29 23:56:11.392146 dracut-cmdline[285]: 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=6e9bced8073e517a5f5178e5412663c3084f53d67852b3dfe0380ce71e6d0edd Apr 29 23:56:11.468679 systemd-resolved[291]: Positive Trust Anchors: Apr 29 23:56:11.468736 systemd-resolved[291]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 29 23:56:11.468796 systemd-resolved[291]: 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 Apr 29 23:56:11.514011 kernel: SCSI subsystem initialized Apr 29 23:56:11.522006 kernel: Loading iSCSI transport class v2.0-870. Apr 29 23:56:11.535058 kernel: iscsi: registered transport (tcp) Apr 29 23:56:11.557206 kernel: iscsi: registered transport (qla4xxx) Apr 29 23:56:11.557282 kernel: QLogic iSCSI HBA Driver Apr 29 23:56:11.656016 kernel: random: crng init done Apr 29 23:56:11.656490 systemd-resolved[291]: Defaulting to hostname 'linux'. Apr 29 23:56:11.660112 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 29 23:56:11.665103 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 29 23:56:11.687858 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 29 23:56:11.702721 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 29 23:56:11.734039 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 29 23:56:11.734151 kernel: device-mapper: uevent: version 1.0.3 Apr 29 23:56:11.734179 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Apr 29 23:56:11.803029 kernel: raid6: neonx8 gen() 6626 MB/s Apr 29 23:56:11.820032 kernel: raid6: neonx4 gen() 6436 MB/s Apr 29 23:56:11.837038 kernel: raid6: neonx2 gen() 5317 MB/s Apr 29 23:56:11.854037 kernel: raid6: neonx1 gen() 3893 MB/s Apr 29 23:56:11.871036 kernel: raid6: int64x8 gen() 3776 MB/s Apr 29 23:56:11.888055 kernel: raid6: int64x4 gen() 3628 MB/s Apr 29 23:56:11.905034 kernel: raid6: int64x2 gen() 3065 MB/s Apr 29 23:56:11.922834 kernel: raid6: int64x1 gen() 2752 MB/s Apr 29 23:56:11.922917 kernel: raid6: using algorithm neonx8 gen() 6626 MB/s Apr 29 23:56:11.940825 kernel: raid6: .... xor() 4905 MB/s, rmw enabled Apr 29 23:56:11.940898 kernel: raid6: using neon recovery algorithm Apr 29 23:56:11.949749 kernel: xor: measuring software checksum speed Apr 29 23:56:11.949821 kernel: 8regs : 10985 MB/sec Apr 29 23:56:11.951005 kernel: 32regs : 11097 MB/sec Apr 29 23:56:11.953269 kernel: arm64_neon : 8962 MB/sec Apr 29 23:56:11.953306 kernel: xor: using function: 32regs (11097 MB/sec) Apr 29 23:56:12.037022 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 29 23:56:12.057063 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 29 23:56:12.069344 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 29 23:56:12.114471 systemd-udevd[471]: Using default interface naming scheme 'v255'. Apr 29 23:56:12.123335 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 29 23:56:12.136243 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 29 23:56:12.186877 dracut-pre-trigger[477]: rd.md=0: removing MD RAID activation Apr 29 23:56:12.245170 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 29 23:56:12.257285 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 29 23:56:12.377776 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 29 23:56:12.393092 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 29 23:56:12.445671 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 29 23:56:12.451084 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 29 23:56:12.453704 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 29 23:56:12.458133 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 29 23:56:12.468393 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 29 23:56:12.511812 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 29 23:56:12.580514 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Apr 29 23:56:12.580576 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Apr 29 23:56:12.602772 kernel: ena 0000:00:05.0: ENA device version: 0.10 Apr 29 23:56:12.603231 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Apr 29 23:56:12.603482 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Apr 29 23:56:12.603512 kernel: nvme nvme0: pci function 0000:00:04.0 Apr 29 23:56:12.603962 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:80:df:60:a7:0b Apr 29 23:56:12.603222 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 29 23:56:12.603448 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:56:12.610229 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 29 23:56:12.615555 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 29 23:56:12.623346 kernel: nvme nvme0: 2/0/0 default/read/poll queues Apr 29 23:56:12.620260 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:56:12.628175 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:56:12.642557 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:56:12.656125 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Apr 29 23:56:12.656164 kernel: GPT:9289727 != 16777215 Apr 29 23:56:12.656199 kernel: GPT:Alternate GPT header not at the end of the disk. Apr 29 23:56:12.656225 kernel: GPT:9289727 != 16777215 Apr 29 23:56:12.656249 kernel: GPT: Use GNU Parted to correct GPT errors. Apr 29 23:56:12.656273 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 29 23:56:12.655458 (udev-worker)[538]: Network interface NamePolicy= disabled on kernel command line. Apr 29 23:56:12.689037 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:56:12.702398 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 29 23:56:12.751486 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:56:12.764008 kernel: BTRFS: device fsid 9647859b-527c-478f-8aa1-9dfa3fa871e3 devid 1 transid 43 /dev/nvme0n1p3 scanned by (udev-worker) (517) Apr 29 23:56:12.781011 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by (udev-worker) (527) Apr 29 23:56:12.837087 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Apr 29 23:56:12.904251 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Apr 29 23:56:12.918235 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Apr 29 23:56:12.920849 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Apr 29 23:56:12.937962 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Apr 29 23:56:12.952298 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 29 23:56:12.965325 disk-uuid[662]: Primary Header is updated. Apr 29 23:56:12.965325 disk-uuid[662]: Secondary Entries is updated. Apr 29 23:56:12.965325 disk-uuid[662]: Secondary Header is updated. Apr 29 23:56:12.976036 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 29 23:56:12.987032 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 29 23:56:13.997027 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 29 23:56:13.997201 disk-uuid[663]: The operation has completed successfully. Apr 29 23:56:14.189902 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 29 23:56:14.192376 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 29 23:56:14.243302 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Apr 29 23:56:14.260589 sh[922]: Success Apr 29 23:56:14.286243 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Apr 29 23:56:14.415268 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Apr 29 23:56:14.424199 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Apr 29 23:56:14.435057 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Apr 29 23:56:14.476020 kernel: BTRFS info (device dm-0): first mount of filesystem 9647859b-527c-478f-8aa1-9dfa3fa871e3 Apr 29 23:56:14.476097 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:56:14.476123 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Apr 29 23:56:14.479860 kernel: BTRFS info (device dm-0): disabling log replay at mount time Apr 29 23:56:14.479929 kernel: BTRFS info (device dm-0): using free space tree Apr 29 23:56:14.508012 kernel: BTRFS info (device dm-0): enabling ssd optimizations Apr 29 23:56:14.524098 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Apr 29 23:56:14.526684 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 29 23:56:14.544482 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 29 23:56:14.558733 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 29 23:56:14.580987 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:56:14.581082 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:56:14.582925 kernel: BTRFS info (device nvme0n1p6): using free space tree Apr 29 23:56:14.594082 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 29 23:56:14.614415 systemd[1]: mnt-oem.mount: Deactivated successfully. Apr 29 23:56:14.617372 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:56:14.630076 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 29 23:56:14.641315 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 29 23:56:14.792488 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 29 23:56:14.807954 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 29 23:56:14.825614 ignition[1023]: Ignition 2.20.0 Apr 29 23:56:14.825637 ignition[1023]: Stage: fetch-offline Apr 29 23:56:14.826100 ignition[1023]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:56:14.826124 ignition[1023]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:56:14.826555 ignition[1023]: Ignition finished successfully Apr 29 23:56:14.845080 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 29 23:56:14.888921 systemd-networkd[1122]: lo: Link UP Apr 29 23:56:14.889399 systemd-networkd[1122]: lo: Gained carrier Apr 29 23:56:14.891874 systemd-networkd[1122]: Enumeration completed Apr 29 23:56:14.892097 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 29 23:56:14.894516 systemd-networkd[1122]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:56:14.894531 systemd-networkd[1122]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 29 23:56:14.907854 systemd[1]: Reached target network.target - Network. Apr 29 23:56:14.917239 systemd-networkd[1122]: eth0: Link UP Apr 29 23:56:14.917254 systemd-networkd[1122]: eth0: Gained carrier Apr 29 23:56:14.917274 systemd-networkd[1122]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:56:14.932264 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Apr 29 23:56:14.951200 systemd-networkd[1122]: eth0: DHCPv4 address 172.31.24.163/20, gateway 172.31.16.1 acquired from 172.31.16.1 Apr 29 23:56:14.962612 ignition[1125]: Ignition 2.20.0 Apr 29 23:56:14.962633 ignition[1125]: Stage: fetch Apr 29 23:56:14.963271 ignition[1125]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:56:14.963297 ignition[1125]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:56:14.963495 ignition[1125]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:56:15.004932 ignition[1125]: PUT result: OK Apr 29 23:56:15.007915 ignition[1125]: parsed url from cmdline: "" Apr 29 23:56:15.008058 ignition[1125]: no config URL provided Apr 29 23:56:15.008924 ignition[1125]: reading system config file "/usr/lib/ignition/user.ign" Apr 29 23:56:15.010002 ignition[1125]: no config at "/usr/lib/ignition/user.ign" Apr 29 23:56:15.010315 ignition[1125]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:56:15.015937 ignition[1125]: PUT result: OK Apr 29 23:56:15.016092 ignition[1125]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Apr 29 23:56:15.019612 ignition[1125]: GET result: OK Apr 29 23:56:15.020761 ignition[1125]: parsing config with SHA512: 8a02bd7ed75314d7116fd53e1607530b083971beeeb444fd58e30bb05a9065ca2ec6d0d57ffa1c8f5f16b2a26b348d83e5df995e710c3a73e1feb5df89912aa0 Apr 29 23:56:15.035855 unknown[1125]: fetched base config from "system" Apr 29 23:56:15.035884 unknown[1125]: fetched base config from "system" Apr 29 23:56:15.037356 ignition[1125]: fetch: fetch complete Apr 29 23:56:15.035898 unknown[1125]: fetched user config from "aws" Apr 29 23:56:15.037369 ignition[1125]: fetch: fetch passed Apr 29 23:56:15.044177 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Apr 29 23:56:15.037474 ignition[1125]: Ignition finished successfully Apr 29 23:56:15.055272 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 29 23:56:15.098532 ignition[1132]: Ignition 2.20.0 Apr 29 23:56:15.099099 ignition[1132]: Stage: kargs Apr 29 23:56:15.099720 ignition[1132]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:56:15.099746 ignition[1132]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:56:15.099956 ignition[1132]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:56:15.102709 ignition[1132]: PUT result: OK Apr 29 23:56:15.112657 ignition[1132]: kargs: kargs passed Apr 29 23:56:15.113034 ignition[1132]: Ignition finished successfully Apr 29 23:56:15.129050 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 29 23:56:15.142341 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 29 23:56:15.169545 ignition[1138]: Ignition 2.20.0 Apr 29 23:56:15.169574 ignition[1138]: Stage: disks Apr 29 23:56:15.170511 ignition[1138]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:56:15.170539 ignition[1138]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:56:15.170706 ignition[1138]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:56:15.174797 ignition[1138]: PUT result: OK Apr 29 23:56:15.183110 ignition[1138]: disks: disks passed Apr 29 23:56:15.183204 ignition[1138]: Ignition finished successfully Apr 29 23:56:15.185380 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 29 23:56:15.192729 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 29 23:56:15.195953 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 29 23:56:15.198323 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 29 23:56:15.200293 systemd[1]: Reached target sysinit.target - System Initialization. Apr 29 23:56:15.204293 systemd[1]: Reached target basic.target - Basic System. Apr 29 23:56:15.231490 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 29 23:56:15.281135 systemd-fsck[1146]: ROOT: clean, 14/553520 files, 52654/553472 blocks Apr 29 23:56:15.288782 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 29 23:56:15.301241 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 29 23:56:15.405019 kernel: EXT4-fs (nvme0n1p9): mounted filesystem cd2ccabc-5b27-4350-bc86-21c9a8411827 r/w with ordered data mode. Quota mode: none. Apr 29 23:56:15.405852 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 29 23:56:15.409594 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 29 23:56:15.427160 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 29 23:56:15.439180 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 29 23:56:15.443409 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Apr 29 23:56:15.443540 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 29 23:56:15.447735 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 29 23:56:15.472026 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/nvme0n1p6 scanned by mount (1165) Apr 29 23:56:15.475007 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:56:15.475079 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:56:15.475853 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 29 23:56:15.484007 kernel: BTRFS info (device nvme0n1p6): using free space tree Apr 29 23:56:15.488422 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 29 23:56:15.500209 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 29 23:56:15.506279 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 29 23:56:15.599776 initrd-setup-root[1189]: cut: /sysroot/etc/passwd: No such file or directory Apr 29 23:56:15.611694 initrd-setup-root[1196]: cut: /sysroot/etc/group: No such file or directory Apr 29 23:56:15.620938 initrd-setup-root[1203]: cut: /sysroot/etc/shadow: No such file or directory Apr 29 23:56:15.631285 initrd-setup-root[1210]: cut: /sysroot/etc/gshadow: No such file or directory Apr 29 23:56:15.824461 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 29 23:56:15.837202 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 29 23:56:15.848623 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 29 23:56:15.863765 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 29 23:56:15.869065 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:56:15.912193 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 29 23:56:15.924479 ignition[1278]: INFO : Ignition 2.20.0 Apr 29 23:56:15.924479 ignition[1278]: INFO : Stage: mount Apr 29 23:56:15.928107 ignition[1278]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 29 23:56:15.928107 ignition[1278]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:56:15.928107 ignition[1278]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:56:15.935385 ignition[1278]: INFO : PUT result: OK Apr 29 23:56:15.940721 ignition[1278]: INFO : mount: mount passed Apr 29 23:56:15.942791 ignition[1278]: INFO : Ignition finished successfully Apr 29 23:56:15.946282 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 29 23:56:15.965159 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 29 23:56:15.987369 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 29 23:56:16.021431 kernel: BTRFS: device label OEM devid 1 transid 17 /dev/nvme0n1p6 scanned by mount (1290) Apr 29 23:56:16.021511 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:56:16.021538 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:56:16.023020 kernel: BTRFS info (device nvme0n1p6): using free space tree Apr 29 23:56:16.029011 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 29 23:56:16.032618 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 29 23:56:16.068774 ignition[1307]: INFO : Ignition 2.20.0 Apr 29 23:56:16.068774 ignition[1307]: INFO : Stage: files Apr 29 23:56:16.072157 ignition[1307]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 29 23:56:16.072157 ignition[1307]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:56:16.076375 ignition[1307]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:56:16.079180 ignition[1307]: INFO : PUT result: OK Apr 29 23:56:16.083303 ignition[1307]: DEBUG : files: compiled without relabeling support, skipping Apr 29 23:56:16.086532 ignition[1307]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 29 23:56:16.086532 ignition[1307]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 29 23:56:16.097905 ignition[1307]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 29 23:56:16.101346 ignition[1307]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 29 23:56:16.104889 unknown[1307]: wrote ssh authorized keys file for user: core Apr 29 23:56:16.107886 ignition[1307]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 29 23:56:16.115517 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/var/resource/http" Apr 29 23:56:16.115517 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET http://kola-fixtures.s3.eu-central-1.amazonaws.com/resources/anonymous: attempt #1 Apr 29 23:56:16.138200 systemd-networkd[1122]: eth0: Gained IPv6LL Apr 29 23:56:16.418148 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(3): GET result: OK Apr 29 23:56:16.418148 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/var/resource/http" Apr 29 23:56:16.418148 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/var/resource/https" Apr 29 23:56:16.427927 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET https://kola-fixtures.s3.eu-central-1.amazonaws.com/resources/anonymous: attempt #1 Apr 29 23:56:16.886593 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(4): GET result: OK Apr 29 23:56:16.889193 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/var/resource/https" Apr 29 23:56:16.889193 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/var/resource/s3-anon" Apr 29 23:56:17.365030 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/var/resource/s3-anon" Apr 29 23:56:17.368844 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 29 23:56:17.368844 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 29 23:56:17.382355 ignition[1307]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 29 23:56:17.382355 ignition[1307]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 29 23:56:17.382355 ignition[1307]: INFO : files: files passed Apr 29 23:56:17.382355 ignition[1307]: INFO : Ignition finished successfully Apr 29 23:56:17.377047 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 29 23:56:17.401413 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 29 23:56:17.415315 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 29 23:56:17.426940 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 29 23:56:17.427555 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 29 23:56:17.460739 initrd-setup-root-after-ignition[1335]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 29 23:56:17.464199 initrd-setup-root-after-ignition[1335]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 29 23:56:17.468038 initrd-setup-root-after-ignition[1339]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 29 23:56:17.473931 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 29 23:56:17.477962 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 29 23:56:17.495269 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 29 23:56:17.556521 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 29 23:56:17.558553 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 29 23:56:17.563743 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 29 23:56:17.567736 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 29 23:56:17.571604 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 29 23:56:17.579309 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 29 23:56:17.613036 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 29 23:56:17.625315 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 29 23:56:17.654848 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 29 23:56:17.657887 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 29 23:56:17.661040 systemd[1]: Stopped target timers.target - Timer Units. Apr 29 23:56:17.664202 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 29 23:56:17.664442 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 29 23:56:17.667202 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 29 23:56:17.671165 systemd[1]: Stopped target basic.target - Basic System. Apr 29 23:56:17.673365 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 29 23:56:17.676467 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 29 23:56:17.679468 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 29 23:56:17.682243 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 29 23:56:17.685609 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 29 23:56:17.688301 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 29 23:56:17.709683 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 29 23:56:17.712431 systemd[1]: Stopped target swap.target - Swaps. Apr 29 23:56:17.717281 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 29 23:56:17.717524 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 29 23:56:17.724555 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 29 23:56:17.728565 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 29 23:56:17.734189 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 29 23:56:17.735127 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 29 23:56:17.739679 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 29 23:56:17.739944 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 29 23:56:17.742937 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 29 23:56:17.744194 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 29 23:56:17.748141 systemd[1]: ignition-files.service: Deactivated successfully. Apr 29 23:56:17.748498 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 29 23:56:17.774522 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 29 23:56:17.782416 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 29 23:56:17.782777 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 29 23:56:17.792688 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 29 23:56:17.795376 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 29 23:56:17.795738 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 29 23:56:17.799529 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 29 23:56:17.799847 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 29 23:56:17.828176 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 29 23:56:17.832769 ignition[1359]: INFO : Ignition 2.20.0 Apr 29 23:56:17.832769 ignition[1359]: INFO : Stage: umount Apr 29 23:56:17.852866 ignition[1359]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 29 23:56:17.852866 ignition[1359]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:56:17.852866 ignition[1359]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:56:17.835095 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 29 23:56:17.864741 ignition[1359]: INFO : PUT result: OK Apr 29 23:56:17.867597 ignition[1359]: INFO : umount: umount passed Apr 29 23:56:17.872463 ignition[1359]: INFO : Ignition finished successfully Apr 29 23:56:17.872078 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 29 23:56:17.873121 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 29 23:56:17.883432 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 29 23:56:17.884732 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 29 23:56:17.887121 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 29 23:56:17.890738 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 29 23:56:17.890856 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 29 23:56:17.897898 systemd[1]: ignition-fetch.service: Deactivated successfully. Apr 29 23:56:17.898138 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Apr 29 23:56:17.900296 systemd[1]: Stopped target network.target - Network. Apr 29 23:56:17.902173 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 29 23:56:17.902302 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 29 23:56:17.904849 systemd[1]: Stopped target paths.target - Path Units. Apr 29 23:56:17.906904 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 29 23:56:17.911029 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 29 23:56:17.925578 systemd[1]: Stopped target slices.target - Slice Units. Apr 29 23:56:17.927677 systemd[1]: Stopped target sockets.target - Socket Units. Apr 29 23:56:17.934955 systemd[1]: iscsid.socket: Deactivated successfully. Apr 29 23:56:17.935089 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 29 23:56:17.937405 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 29 23:56:17.937489 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 29 23:56:17.939547 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 29 23:56:17.939660 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 29 23:56:17.941751 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 29 23:56:17.941867 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 29 23:56:17.945733 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 29 23:56:17.948309 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 29 23:56:17.954064 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 29 23:56:17.956036 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 29 23:56:17.962171 systemd-networkd[1122]: eth0: DHCPv6 lease lost Apr 29 23:56:17.962576 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 29 23:56:17.962800 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 29 23:56:17.971613 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 29 23:56:17.971919 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 29 23:56:17.976167 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 29 23:56:17.976376 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 29 23:56:18.004864 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 29 23:56:18.005217 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 29 23:56:18.021102 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 29 23:56:18.025146 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 29 23:56:18.025277 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 29 23:56:18.032962 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 29 23:56:18.033962 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 29 23:56:18.037079 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 29 23:56:18.037193 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 29 23:56:18.039368 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 29 23:56:18.039474 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 29 23:56:18.042364 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 29 23:56:18.077684 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 29 23:56:18.080909 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 29 23:56:18.086102 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 29 23:56:18.086283 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 29 23:56:18.092687 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 29 23:56:18.092775 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Apr 29 23:56:18.096580 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 29 23:56:18.096695 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 29 23:56:18.099214 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 29 23:56:18.099324 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 29 23:56:18.101247 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 29 23:56:18.101343 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:56:18.131422 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 29 23:56:18.133868 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 29 23:56:18.134021 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 29 23:56:18.137008 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 29 23:56:18.137116 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:56:18.142958 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 29 23:56:18.145897 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 29 23:56:18.154296 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 29 23:56:18.156061 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 29 23:56:18.162836 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 29 23:56:18.186359 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 29 23:56:18.208099 systemd[1]: Switching root. Apr 29 23:56:18.254300 systemd-journald[252]: Journal stopped Apr 29 23:56:20.080190 systemd-journald[252]: Received SIGTERM from PID 1 (systemd). Apr 29 23:56:20.080346 kernel: SELinux: policy capability network_peer_controls=1 Apr 29 23:56:20.080405 kernel: SELinux: policy capability open_perms=1 Apr 29 23:56:20.080438 kernel: SELinux: policy capability extended_socket_class=1 Apr 29 23:56:20.080469 kernel: SELinux: policy capability always_check_network=0 Apr 29 23:56:20.080501 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 29 23:56:20.080534 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 29 23:56:20.080573 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 29 23:56:20.080604 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 29 23:56:20.080635 kernel: audit: type=1403 audit(1745970978.422:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 29 23:56:20.080668 systemd[1]: Successfully loaded SELinux policy in 53.453ms. Apr 29 23:56:20.080723 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 27.528ms. Apr 29 23:56:20.080771 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Apr 29 23:56:20.080804 systemd[1]: Detected virtualization amazon. Apr 29 23:56:20.080835 systemd[1]: Detected architecture arm64. Apr 29 23:56:20.080870 systemd[1]: Detected first boot. Apr 29 23:56:20.080909 systemd[1]: Initializing machine ID from VM UUID. Apr 29 23:56:20.080947 zram_generator::config[1401]: No configuration found. Apr 29 23:56:20.085190 systemd[1]: Populated /etc with preset unit settings. Apr 29 23:56:20.085245 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 29 23:56:20.085278 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 29 23:56:20.085320 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 29 23:56:20.085364 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 29 23:56:20.085397 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 29 23:56:20.085427 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 29 23:56:20.085458 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 29 23:56:20.085488 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 29 23:56:20.085519 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 29 23:56:20.085550 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 29 23:56:20.085583 systemd[1]: Created slice user.slice - User and Session Slice. Apr 29 23:56:20.085613 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 29 23:56:20.085646 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 29 23:56:20.085675 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 29 23:56:20.085708 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 29 23:56:20.085738 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 29 23:56:20.085767 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 29 23:56:20.085799 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Apr 29 23:56:20.085828 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 29 23:56:20.085861 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 29 23:56:20.085892 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 29 23:56:20.085924 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 29 23:56:20.085955 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 29 23:56:20.097087 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 29 23:56:20.097149 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 29 23:56:20.097181 systemd[1]: Reached target slices.target - Slice Units. Apr 29 23:56:20.097213 systemd[1]: Reached target swap.target - Swaps. Apr 29 23:56:20.097257 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 29 23:56:20.097296 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 29 23:56:20.097328 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 29 23:56:20.097363 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 29 23:56:20.097398 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 29 23:56:20.097429 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 29 23:56:20.097463 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 29 23:56:20.097497 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 29 23:56:20.097530 systemd[1]: Mounting media.mount - External Media Directory... Apr 29 23:56:20.097578 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 29 23:56:20.097610 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 29 23:56:20.097640 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 29 23:56:20.097672 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). Apr 29 23:56:20.097704 systemd[1]: Reached target machines.target - Containers. Apr 29 23:56:20.097738 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 29 23:56:20.097771 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:56:20.097802 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 29 23:56:20.097843 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 29 23:56:20.097877 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 29 23:56:20.097907 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 29 23:56:20.097937 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 29 23:56:20.105459 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 29 23:56:20.105551 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 29 23:56:20.105588 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 29 23:56:20.105618 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 29 23:56:20.105652 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 29 23:56:20.105692 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 29 23:56:20.105725 systemd[1]: Stopped systemd-fsck-usr.service. Apr 29 23:56:20.105755 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 29 23:56:20.105788 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 29 23:56:20.105818 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 29 23:56:20.105849 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 29 23:56:20.105880 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 29 23:56:20.105912 systemd[1]: verity-setup.service: Deactivated successfully. Apr 29 23:56:20.105941 systemd[1]: Stopped verity-setup.service. Apr 29 23:56:20.108060 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 29 23:56:20.108147 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 29 23:56:20.108191 systemd[1]: Mounted media.mount - External Media Directory. Apr 29 23:56:20.108224 kernel: fuse: init (API version 7.39) Apr 29 23:56:20.108259 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 29 23:56:20.108301 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 29 23:56:20.108342 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 29 23:56:20.108375 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 29 23:56:20.108407 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 29 23:56:20.108438 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 29 23:56:20.108471 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 29 23:56:20.108503 kernel: loop: module loaded Apr 29 23:56:20.108533 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 29 23:56:20.108574 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 29 23:56:20.108615 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 29 23:56:20.108645 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 29 23:56:20.108678 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 29 23:56:20.108709 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 29 23:56:20.108745 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 29 23:56:20.108777 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 29 23:56:20.108819 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 29 23:56:20.108852 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 29 23:56:20.108892 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 29 23:56:20.117607 systemd-journald[1483]: Collecting audit messages is disabled. Apr 29 23:56:20.117700 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 29 23:56:20.117738 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 29 23:56:20.117780 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 29 23:56:20.117815 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 29 23:56:20.117849 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Apr 29 23:56:20.117879 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 29 23:56:20.117909 systemd-journald[1483]: Journal started Apr 29 23:56:20.117959 systemd-journald[1483]: Runtime Journal (/run/log/journal/ec24895954ed57d00ed0fdc63925a521) is 8.0M, max 75.3M, 67.3M free. Apr 29 23:56:19.470596 systemd[1]: Queued start job for default target multi-user.target. Apr 29 23:56:19.499735 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Apr 29 23:56:19.500717 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 29 23:56:20.131002 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 29 23:56:20.131098 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:56:20.147270 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 29 23:56:20.154054 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 29 23:56:20.174252 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 29 23:56:20.174343 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 29 23:56:20.185897 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 29 23:56:20.197066 kernel: ACPI: bus type drm_connector registered Apr 29 23:56:20.197143 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 29 23:56:20.206028 systemd[1]: Started systemd-journald.service - Journal Service. Apr 29 23:56:20.212168 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 29 23:56:20.215115 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 29 23:56:20.221313 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 29 23:56:20.224112 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 29 23:56:20.227127 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 29 23:56:20.249207 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 29 23:56:20.263206 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 29 23:56:20.278898 kernel: loop0: detected capacity change from 0 to 53784 Apr 29 23:56:20.325907 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 29 23:56:20.340791 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 29 23:56:20.358339 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Apr 29 23:56:20.374308 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 29 23:56:20.378038 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 29 23:56:20.400049 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 29 23:56:20.428936 systemd-journald[1483]: Time spent on flushing to /var/log/journal/ec24895954ed57d00ed0fdc63925a521 is 100.875ms for 898 entries. Apr 29 23:56:20.428936 systemd-journald[1483]: System Journal (/var/log/journal/ec24895954ed57d00ed0fdc63925a521) is 8.0M, max 195.6M, 187.6M free. Apr 29 23:56:20.555391 systemd-journald[1483]: Received client request to flush runtime journal. Apr 29 23:56:20.555503 kernel: loop1: detected capacity change from 0 to 116808 Apr 29 23:56:20.555539 kernel: loop2: detected capacity change from 0 to 113536 Apr 29 23:56:20.433426 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 29 23:56:20.438184 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Apr 29 23:56:20.490741 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 29 23:56:20.506384 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Apr 29 23:56:20.565635 udevadm[1548]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Apr 29 23:56:20.569691 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 29 23:56:20.581315 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 29 23:56:20.599675 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 29 23:56:20.630059 kernel: loop3: detected capacity change from 0 to 53784 Apr 29 23:56:20.651561 kernel: loop4: detected capacity change from 0 to 116808 Apr 29 23:56:20.688285 systemd-tmpfiles[1552]: ACLs are not supported, ignoring. Apr 29 23:56:20.688331 systemd-tmpfiles[1552]: ACLs are not supported, ignoring. Apr 29 23:56:20.707176 kernel: loop5: detected capacity change from 0 to 113536 Apr 29 23:56:20.701952 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 29 23:56:20.740324 (sd-merge)[1554]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Apr 29 23:56:20.743073 (sd-merge)[1554]: Merged extensions into '/usr'. Apr 29 23:56:20.760665 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 29 23:56:20.774514 systemd[1]: Starting ensure-sysext.service... Apr 29 23:56:20.790410 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 29 23:56:20.850925 systemd[1]: Reloading requested from client PID 1558 ('systemctl') (unit ensure-sysext.service)... Apr 29 23:56:20.850963 systemd[1]: Reloading... Apr 29 23:56:20.907132 systemd-tmpfiles[1559]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 29 23:56:20.907934 systemd-tmpfiles[1559]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Apr 29 23:56:20.919092 systemd-tmpfiles[1559]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 29 23:56:20.921282 systemd-tmpfiles[1559]: ACLs are not supported, ignoring. Apr 29 23:56:20.921455 systemd-tmpfiles[1559]: ACLs are not supported, ignoring. Apr 29 23:56:20.953416 systemd-tmpfiles[1559]: Detected autofs mount point /boot during canonicalization of boot. Apr 29 23:56:20.953439 systemd-tmpfiles[1559]: Skipping /boot Apr 29 23:56:21.001589 systemd-tmpfiles[1559]: Detected autofs mount point /boot during canonicalization of boot. Apr 29 23:56:21.001783 systemd-tmpfiles[1559]: Skipping /boot Apr 29 23:56:21.079032 zram_generator::config[1587]: No configuration found. Apr 29 23:56:21.431044 ldconfig[1502]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 29 23:56:21.511768 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. Apr 29 23:56:21.628647 systemd[1]: Reloading finished in 776 ms. Apr 29 23:56:21.676107 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 29 23:56:21.685326 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 29 23:56:21.724542 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 29 23:56:21.731496 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 29 23:56:21.746472 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 29 23:56:21.755391 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 29 23:56:21.763377 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 29 23:56:21.778119 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:56:21.788534 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 29 23:56:21.802513 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 29 23:56:21.825645 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 29 23:56:21.827892 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:56:21.835840 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:56:21.836629 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:56:21.847098 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 29 23:56:21.848023 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 29 23:56:21.857595 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:56:21.890210 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 29 23:56:21.892619 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:56:21.892939 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 29 23:56:21.893308 systemd[1]: Reached target time-set.target - System Time Set. Apr 29 23:56:21.900131 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 29 23:56:21.927881 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 29 23:56:21.931859 systemd[1]: Finished ensure-sysext.service. Apr 29 23:56:21.935863 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 29 23:56:21.936231 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 29 23:56:21.952356 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 29 23:56:21.955777 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 29 23:56:21.957219 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 29 23:56:21.970762 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 29 23:56:21.973041 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 29 23:56:21.976959 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 29 23:56:21.991955 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 29 23:56:22.009301 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 29 23:56:22.021313 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 29 23:56:22.071194 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 29 23:56:22.106900 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 29 23:56:22.110706 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). Apr 29 23:56:22.114472 augenrules[1681]: No rules Apr 29 23:56:22.117882 systemd[1]: audit-rules.service: Deactivated successfully. Apr 29 23:56:22.118495 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 29 23:56:22.132721 systemd-udevd[1669]: Using default interface naming scheme 'v255'. Apr 29 23:56:22.136876 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 29 23:56:22.185549 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 29 23:56:22.203123 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 29 23:56:22.362905 systemd-resolved[1644]: Positive Trust Anchors: Apr 29 23:56:22.364182 systemd-resolved[1644]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 29 23:56:22.364258 systemd-resolved[1644]: 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 Apr 29 23:56:22.381459 systemd-resolved[1644]: Defaulting to hostname 'linux'. Apr 29 23:56:22.387964 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 29 23:56:22.391811 systemd-networkd[1696]: lo: Link UP Apr 29 23:56:22.391840 systemd-networkd[1696]: lo: Gained carrier Apr 29 23:56:22.392271 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 29 23:56:22.402454 systemd-networkd[1696]: Enumeration completed Apr 29 23:56:22.402671 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 29 23:56:22.406281 systemd[1]: Reached target network.target - Network. Apr 29 23:56:22.417339 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 29 23:56:22.470136 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Apr 29 23:56:22.494851 (udev-worker)[1710]: Network interface NamePolicy= disabled on kernel command line. Apr 29 23:56:22.637577 systemd-networkd[1696]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:56:22.637601 systemd-networkd[1696]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 29 23:56:22.642830 systemd-networkd[1696]: eth0: Link UP Apr 29 23:56:22.643247 systemd-networkd[1696]: eth0: Gained carrier Apr 29 23:56:22.643296 systemd-networkd[1696]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:56:22.667190 systemd-networkd[1696]: eth0: DHCPv4 address 172.31.24.163/20, gateway 172.31.16.1 acquired from 172.31.16.1 Apr 29 23:56:22.688055 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 43 scanned by (udev-worker) (1706) Apr 29 23:56:22.700773 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:56:22.895080 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:56:22.924114 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Apr 29 23:56:22.927294 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Apr 29 23:56:22.944328 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Apr 29 23:56:22.950441 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 29 23:56:22.968326 lvm[1816]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 29 23:56:22.984632 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 29 23:56:23.021500 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Apr 29 23:56:23.024855 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 29 23:56:23.027155 systemd[1]: Reached target sysinit.target - System Initialization. Apr 29 23:56:23.029728 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 29 23:56:23.032607 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Apr 29 23:56:23.035549 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 29 23:56:23.038022 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 29 23:56:23.040698 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 29 23:56:23.043418 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 29 23:56:23.043503 systemd[1]: Reached target paths.target - Path Units. Apr 29 23:56:23.045352 systemd[1]: Reached target timers.target - Timer Units. Apr 29 23:56:23.050209 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 29 23:56:23.055833 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 29 23:56:23.065599 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 29 23:56:23.071408 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Apr 29 23:56:23.079211 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 29 23:56:23.083830 systemd[1]: Reached target sockets.target - Socket Units. Apr 29 23:56:23.086162 systemd[1]: Reached target basic.target - Basic System. Apr 29 23:56:23.088186 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 29 23:56:23.088258 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 29 23:56:23.094234 systemd[1]: Starting containerd.service - containerd container runtime... Apr 29 23:56:23.101782 lvm[1823]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 29 23:56:23.110247 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Apr 29 23:56:23.124348 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 29 23:56:23.138848 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 29 23:56:23.144168 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 29 23:56:23.146264 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). Apr 29 23:56:23.150954 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 29 23:56:23.156671 systemd[1]: Started ntpd.service - Network Time Service. Apr 29 23:56:23.165263 systemd[1]: Starting setup-oem.service - Setup OEM... Apr 29 23:56:23.182594 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 29 23:56:23.192335 jq[1827]: false Apr 29 23:56:23.191662 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 29 23:56:23.203497 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 29 23:56:23.207859 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 29 23:56:23.208882 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 29 23:56:23.226549 systemd[1]: Starting update-engine.service - Update Engine... Apr 29 23:56:23.233193 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 29 23:56:23.238911 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Apr 29 23:56:23.247383 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 29 23:56:23.247797 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 29 23:56:23.270963 dbus-daemon[1826]: [system] SELinux support is enabled Apr 29 23:56:23.272235 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 29 23:56:23.274683 dbus-daemon[1826]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1696 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Apr 29 23:56:23.282904 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). Apr 29 23:56:23.284780 dbus-daemon[1826]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 29 23:56:23.282993 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 29 23:56:23.285507 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). Apr 29 23:56:23.285547 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 29 23:56:23.333010 extend-filesystems[1828]: Found loop3 Apr 29 23:56:23.333010 extend-filesystems[1828]: Found loop4 Apr 29 23:56:23.333010 extend-filesystems[1828]: Found loop5 Apr 29 23:56:23.333010 extend-filesystems[1828]: Found nvme0n1 Apr 29 23:56:23.333010 extend-filesystems[1828]: Found nvme0n1p1 Apr 29 23:56:23.333010 extend-filesystems[1828]: Found nvme0n1p2 Apr 29 23:56:23.333010 extend-filesystems[1828]: Found nvme0n1p3 Apr 29 23:56:23.333010 extend-filesystems[1828]: Found usr Apr 29 23:56:23.333010 extend-filesystems[1828]: Found nvme0n1p4 Apr 29 23:56:23.333010 extend-filesystems[1828]: Found nvme0n1p6 Apr 29 23:56:23.333010 extend-filesystems[1828]: Found nvme0n1p7 Apr 29 23:56:23.333010 extend-filesystems[1828]: Found nvme0n1p9 Apr 29 23:56:23.333010 extend-filesystems[1828]: Checking size of /dev/nvme0n1p9 Apr 29 23:56:23.334688 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Apr 29 23:56:23.358690 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 29 23:56:23.363369 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 29 23:56:23.408772 ntpd[1830]: ntpd 4.2.8p17@1.4004-o Tue Apr 29 21:35:04 UTC 2025 (1): Starting Apr 29 23:56:23.411423 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: ntpd 4.2.8p17@1.4004-o Tue Apr 29 21:35:04 UTC 2025 (1): Starting Apr 29 23:56:23.411423 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Apr 29 23:56:23.411423 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: ---------------------------------------------------- Apr 29 23:56:23.411423 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: ntp-4 is maintained by Network Time Foundation, Apr 29 23:56:23.411423 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Apr 29 23:56:23.411423 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: corporation. Support and training for ntp-4 are Apr 29 23:56:23.411423 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: available at https://www.nwtime.org/support Apr 29 23:56:23.411423 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: ---------------------------------------------------- Apr 29 23:56:23.408839 ntpd[1830]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Apr 29 23:56:23.408860 ntpd[1830]: ---------------------------------------------------- Apr 29 23:56:23.408879 ntpd[1830]: ntp-4 is maintained by Network Time Foundation, Apr 29 23:56:23.408898 ntpd[1830]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Apr 29 23:56:23.408916 ntpd[1830]: corporation. Support and training for ntp-4 are Apr 29 23:56:23.408936 ntpd[1830]: available at https://www.nwtime.org/support Apr 29 23:56:23.408954 ntpd[1830]: ---------------------------------------------------- Apr 29 23:56:23.415406 ntpd[1830]: proto: precision = 0.108 usec (-23) Apr 29 23:56:23.417890 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: proto: precision = 0.108 usec (-23) Apr 29 23:56:23.417890 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: basedate set to 2025-04-17 Apr 29 23:56:23.417890 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: gps base set to 2025-04-20 (week 2363) Apr 29 23:56:23.415927 ntpd[1830]: basedate set to 2025-04-17 Apr 29 23:56:23.415960 ntpd[1830]: gps base set to 2025-04-20 (week 2363) Apr 29 23:56:23.420957 ntpd[1830]: Listen and drop on 0 v6wildcard [::]:123 Apr 29 23:56:23.421334 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: Listen and drop on 0 v6wildcard [::]:123 Apr 29 23:56:23.421531 ntpd[1830]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 29 23:56:23.421666 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 29 23:56:23.422070 ntpd[1830]: Listen normally on 2 lo 127.0.0.1:123 Apr 29 23:56:23.422100 systemd[1]: motdgen.service: Deactivated successfully. Apr 29 23:56:23.422399 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: Listen normally on 2 lo 127.0.0.1:123 Apr 29 23:56:23.422565 ntpd[1830]: Listen normally on 3 eth0 172.31.24.163:123 Apr 29 23:56:23.424013 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: Listen normally on 3 eth0 172.31.24.163:123 Apr 29 23:56:23.424013 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: Listen normally on 4 lo [::1]:123 Apr 29 23:56:23.424013 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: bind(21) AF_INET6 fe80::480:dfff:fe60:a70b%2#123 flags 0x11 failed: Cannot assign requested address Apr 29 23:56:23.424013 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: unable to create socket on eth0 (5) for fe80::480:dfff:fe60:a70b%2#123 Apr 29 23:56:23.424013 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: failed to init interface for address fe80::480:dfff:fe60:a70b%2 Apr 29 23:56:23.424013 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: Listening on routing socket on fd #21 for interface updates Apr 29 23:56:23.422763 ntpd[1830]: Listen normally on 4 lo [::1]:123 Apr 29 23:56:23.424135 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 29 23:56:23.422842 ntpd[1830]: bind(21) AF_INET6 fe80::480:dfff:fe60:a70b%2#123 flags 0x11 failed: Cannot assign requested address Apr 29 23:56:23.422880 ntpd[1830]: unable to create socket on eth0 (5) for fe80::480:dfff:fe60:a70b%2#123 Apr 29 23:56:23.422906 ntpd[1830]: failed to init interface for address fe80::480:dfff:fe60:a70b%2 Apr 29 23:56:23.422998 ntpd[1830]: Listening on routing socket on fd #21 for interface updates Apr 29 23:56:23.427484 ntpd[1830]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 29 23:56:23.429166 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 29 23:56:23.429166 ntpd[1830]: 29 Apr 23:56:23 ntpd[1830]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 29 23:56:23.427549 ntpd[1830]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 29 23:56:23.447223 jq[1837]: true Apr 29 23:56:23.479377 extend-filesystems[1828]: Resized partition /dev/nvme0n1p9 Apr 29 23:56:23.490014 extend-filesystems[1871]: resize2fs 1.47.1 (20-May-2024) Apr 29 23:56:23.500712 (ntainerd)[1864]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 29 23:56:23.517010 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Apr 29 23:56:23.519837 update_engine[1835]: I20250429 23:56:23.519652 1835 main.cc:92] Flatcar Update Engine starting Apr 29 23:56:23.538158 systemd[1]: Started update-engine.service - Update Engine. Apr 29 23:56:23.546392 update_engine[1835]: I20250429 23:56:23.546288 1835 update_check_scheduler.cc:74] Next update check in 3m27s Apr 29 23:56:23.551847 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 29 23:56:23.557923 systemd[1]: Finished setup-oem.service - Setup OEM. Apr 29 23:56:23.571005 coreos-metadata[1825]: Apr 29 23:56:23.569 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Apr 29 23:56:23.572541 coreos-metadata[1825]: Apr 29 23:56:23.572 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Apr 29 23:56:23.574382 jq[1867]: true Apr 29 23:56:23.581370 coreos-metadata[1825]: Apr 29 23:56:23.581 INFO Fetch successful Apr 29 23:56:23.581370 coreos-metadata[1825]: Apr 29 23:56:23.581 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Apr 29 23:56:23.584770 coreos-metadata[1825]: Apr 29 23:56:23.584 INFO Fetch successful Apr 29 23:56:23.584770 coreos-metadata[1825]: Apr 29 23:56:23.584 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Apr 29 23:56:23.586148 coreos-metadata[1825]: Apr 29 23:56:23.585 INFO Fetch successful Apr 29 23:56:23.586148 coreos-metadata[1825]: Apr 29 23:56:23.585 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Apr 29 23:56:23.588303 coreos-metadata[1825]: Apr 29 23:56:23.586 INFO Fetch successful Apr 29 23:56:23.588303 coreos-metadata[1825]: Apr 29 23:56:23.586 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Apr 29 23:56:23.589235 coreos-metadata[1825]: Apr 29 23:56:23.589 INFO Fetch failed with 404: resource not found Apr 29 23:56:23.589235 coreos-metadata[1825]: Apr 29 23:56:23.589 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Apr 29 23:56:23.595457 coreos-metadata[1825]: Apr 29 23:56:23.590 INFO Fetch successful Apr 29 23:56:23.595457 coreos-metadata[1825]: Apr 29 23:56:23.590 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Apr 29 23:56:23.595964 coreos-metadata[1825]: Apr 29 23:56:23.595 INFO Fetch successful Apr 29 23:56:23.595964 coreos-metadata[1825]: Apr 29 23:56:23.595 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Apr 29 23:56:23.599232 coreos-metadata[1825]: Apr 29 23:56:23.599 INFO Fetch successful Apr 29 23:56:23.599232 coreos-metadata[1825]: Apr 29 23:56:23.599 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Apr 29 23:56:23.600208 coreos-metadata[1825]: Apr 29 23:56:23.599 INFO Fetch successful Apr 29 23:56:23.600208 coreos-metadata[1825]: Apr 29 23:56:23.600 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Apr 29 23:56:23.606722 coreos-metadata[1825]: Apr 29 23:56:23.606 INFO Fetch successful Apr 29 23:56:23.695952 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Apr 29 23:56:23.696112 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 43 scanned by (udev-worker) (1706) Apr 29 23:56:23.724489 extend-filesystems[1871]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Apr 29 23:56:23.724489 extend-filesystems[1871]: old_desc_blocks = 1, new_desc_blocks = 1 Apr 29 23:56:23.724489 extend-filesystems[1871]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Apr 29 23:56:23.737614 extend-filesystems[1828]: Resized filesystem in /dev/nvme0n1p9 Apr 29 23:56:23.733359 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 29 23:56:23.733772 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 29 23:56:23.758163 systemd-logind[1834]: Watching system buttons on /dev/input/event0 (Power Button) Apr 29 23:56:23.758208 systemd-logind[1834]: Watching system buttons on /dev/input/event1 (Sleep Button) Apr 29 23:56:23.762184 systemd-logind[1834]: New seat seat0. Apr 29 23:56:23.775067 systemd[1]: Started systemd-logind.service - User Login Management. Apr 29 23:56:23.788576 bash[1914]: Updated "/home/core/.ssh/authorized_keys" Apr 29 23:56:23.786025 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 29 23:56:23.792702 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Apr 29 23:56:23.801737 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 29 23:56:23.893827 systemd[1]: Starting sshkeys.service... Apr 29 23:56:23.913564 dbus-daemon[1826]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 29 23:56:23.913853 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Apr 29 23:56:23.920987 dbus-daemon[1826]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1848 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Apr 29 23:56:23.928829 systemd[1]: Starting polkit.service - Authorization Manager... Apr 29 23:56:23.970932 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Apr 29 23:56:23.985669 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Apr 29 23:56:24.024373 polkitd[1949]: Started polkitd version 121 Apr 29 23:56:24.059142 polkitd[1949]: Loading rules from directory /etc/polkit-1/rules.d Apr 29 23:56:24.059272 polkitd[1949]: Loading rules from directory /usr/share/polkit-1/rules.d Apr 29 23:56:24.079862 polkitd[1949]: Finished loading, compiling and executing 2 rules Apr 29 23:56:24.102701 dbus-daemon[1826]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 29 23:56:24.104112 systemd[1]: Started polkit.service - Authorization Manager. Apr 29 23:56:24.108726 locksmithd[1875]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 29 23:56:24.111090 polkitd[1949]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Apr 29 23:56:24.183303 systemd-resolved[1644]: System hostname changed to 'ip-172-31-24-163'. Apr 29 23:56:24.183304 systemd-hostnamed[1848]: Hostname set to (transient) Apr 29 23:56:24.236667 coreos-metadata[1968]: Apr 29 23:56:24.234 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Apr 29 23:56:24.236667 coreos-metadata[1968]: Apr 29 23:56:24.236 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Apr 29 23:56:24.241011 coreos-metadata[1968]: Apr 29 23:56:24.239 INFO Fetch successful Apr 29 23:56:24.241011 coreos-metadata[1968]: Apr 29 23:56:24.239 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Apr 29 23:56:24.241011 coreos-metadata[1968]: Apr 29 23:56:24.240 INFO Fetch successful Apr 29 23:56:24.245558 unknown[1968]: wrote ssh authorized keys file for user: core Apr 29 23:56:24.318720 update-ssh-keys[2011]: Updated "/home/core/.ssh/authorized_keys" Apr 29 23:56:24.320831 containerd[1864]: time="2025-04-29T23:56:24.320648024Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Apr 29 23:56:24.327101 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Apr 29 23:56:24.343133 systemd[1]: Finished sshkeys.service. Apr 29 23:56:24.410517 ntpd[1830]: bind(24) AF_INET6 fe80::480:dfff:fe60:a70b%2#123 flags 0x11 failed: Cannot assign requested address Apr 29 23:56:24.411502 ntpd[1830]: 29 Apr 23:56:24 ntpd[1830]: bind(24) AF_INET6 fe80::480:dfff:fe60:a70b%2#123 flags 0x11 failed: Cannot assign requested address Apr 29 23:56:24.411502 ntpd[1830]: 29 Apr 23:56:24 ntpd[1830]: unable to create socket on eth0 (6) for fe80::480:dfff:fe60:a70b%2#123 Apr 29 23:56:24.411502 ntpd[1830]: 29 Apr 23:56:24 ntpd[1830]: failed to init interface for address fe80::480:dfff:fe60:a70b%2 Apr 29 23:56:24.411230 ntpd[1830]: unable to create socket on eth0 (6) for fe80::480:dfff:fe60:a70b%2#123 Apr 29 23:56:24.411263 ntpd[1830]: failed to init interface for address fe80::480:dfff:fe60:a70b%2 Apr 29 23:56:24.417889 containerd[1864]: time="2025-04-29T23:56:24.417779037Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:56:24.423377 containerd[1864]: time="2025-04-29T23:56:24.423248289Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.88-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:56:24.423377 containerd[1864]: time="2025-04-29T23:56:24.423346113Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 29 23:56:24.423561 containerd[1864]: time="2025-04-29T23:56:24.423391077Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 29 23:56:24.423865 containerd[1864]: time="2025-04-29T23:56:24.423773853Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Apr 29 23:56:24.423865 containerd[1864]: time="2025-04-29T23:56:24.423852741Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Apr 29 23:56:24.424086 containerd[1864]: time="2025-04-29T23:56:24.424053009Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:56:24.424141 containerd[1864]: time="2025-04-29T23:56:24.424094517Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:56:24.424519 containerd[1864]: time="2025-04-29T23:56:24.424438749Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 Apr 29 23:56:24.424519 containerd[1864]: time="2025-04-29T23:56:24.424500741Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 29 23:56:24.424649 containerd[1864]: time="2025-04-29T23:56:24.424543245Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:56:24.424649 containerd[1864]: time="2025-04-29T23:56:24.424568853Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 29 23:56:24.424836 containerd[1864]: time="2025-04-29T23:56:24.424788021Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:56:24.430435 containerd[1864]: time="2025-04-29T23:56:24.429548649Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:56:24.430435 containerd[1864]: time="2025-04-29T23:56:24.429830709Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:56:24.430435 containerd[1864]: time="2025-04-29T23:56:24.429868017Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 29 23:56:24.430435 containerd[1864]: time="2025-04-29T23:56:24.430179969Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 29 23:56:24.430435 containerd[1864]: time="2025-04-29T23:56:24.430330473Z" level=info msg="metadata content store policy set" policy=shared Apr 29 23:56:24.437306 containerd[1864]: time="2025-04-29T23:56:24.437244993Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 29 23:56:24.437575 containerd[1864]: time="2025-04-29T23:56:24.437537733Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 29 23:56:24.438058 containerd[1864]: time="2025-04-29T23:56:24.438005337Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Apr 29 23:56:24.438328 containerd[1864]: time="2025-04-29T23:56:24.438276177Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Apr 29 23:56:24.438506 containerd[1864]: time="2025-04-29T23:56:24.438450189Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 29 23:56:24.440064 containerd[1864]: time="2025-04-29T23:56:24.438899001Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 29 23:56:24.440064 containerd[1864]: time="2025-04-29T23:56:24.439403325Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 29 23:56:24.440064 containerd[1864]: time="2025-04-29T23:56:24.439674645Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Apr 29 23:56:24.440064 containerd[1864]: time="2025-04-29T23:56:24.439713621Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Apr 29 23:56:24.440064 containerd[1864]: time="2025-04-29T23:56:24.439750821Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Apr 29 23:56:24.440064 containerd[1864]: time="2025-04-29T23:56:24.439790325Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 29 23:56:24.440064 containerd[1864]: time="2025-04-29T23:56:24.439821753Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 29 23:56:24.440064 containerd[1864]: time="2025-04-29T23:56:24.439851585Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 29 23:56:24.440064 containerd[1864]: time="2025-04-29T23:56:24.439885173Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 29 23:56:24.440064 containerd[1864]: time="2025-04-29T23:56:24.439920921Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 29 23:56:24.440573 containerd[1864]: time="2025-04-29T23:56:24.439954197Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 29 23:56:24.440776 containerd[1864]: time="2025-04-29T23:56:24.440722713Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 29 23:56:24.440896 containerd[1864]: time="2025-04-29T23:56:24.440868417Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 29 23:56:24.441091 containerd[1864]: time="2025-04-29T23:56:24.441049089Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.441211 containerd[1864]: time="2025-04-29T23:56:24.441184689Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.441392 containerd[1864]: time="2025-04-29T23:56:24.441362541Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.441555 containerd[1864]: time="2025-04-29T23:56:24.441526221Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.441703 containerd[1864]: time="2025-04-29T23:56:24.441673281Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.441845 containerd[1864]: time="2025-04-29T23:56:24.441814881Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.442126 containerd[1864]: time="2025-04-29T23:56:24.442065357Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.442338 containerd[1864]: time="2025-04-29T23:56:24.442286793Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.442488 containerd[1864]: time="2025-04-29T23:56:24.442453893Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.442650 containerd[1864]: time="2025-04-29T23:56:24.442618029Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.442851 containerd[1864]: time="2025-04-29T23:56:24.442795461Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.443063 containerd[1864]: time="2025-04-29T23:56:24.443031405Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.443208 containerd[1864]: time="2025-04-29T23:56:24.443179149Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.443358 containerd[1864]: time="2025-04-29T23:56:24.443328201Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Apr 29 23:56:24.443538 containerd[1864]: time="2025-04-29T23:56:24.443491749Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.443708 containerd[1864]: time="2025-04-29T23:56:24.443660961Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.443839 containerd[1864]: time="2025-04-29T23:56:24.443808441Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 29 23:56:24.444329 containerd[1864]: time="2025-04-29T23:56:24.444204741Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 29 23:56:24.444543 containerd[1864]: time="2025-04-29T23:56:24.444297105Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Apr 29 23:56:24.444719 containerd[1864]: time="2025-04-29T23:56:24.444504417Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 29 23:56:24.444719 containerd[1864]: time="2025-04-29T23:56:24.444664953Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Apr 29 23:56:24.444927 containerd[1864]: time="2025-04-29T23:56:24.444696549Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.445109 containerd[1864]: time="2025-04-29T23:56:24.444891513Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Apr 29 23:56:24.445109 containerd[1864]: time="2025-04-29T23:56:24.445047345Z" level=info msg="NRI interface is disabled by configuration." Apr 29 23:56:24.445439 containerd[1864]: time="2025-04-29T23:56:24.445084725Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 29 23:56:24.446302 containerd[1864]: time="2025-04-29T23:56:24.446170761Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} 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}" Apr 29 23:56:24.446685 containerd[1864]: time="2025-04-29T23:56:24.446378493Z" level=info msg="Connect containerd service" Apr 29 23:56:24.447053 containerd[1864]: time="2025-04-29T23:56:24.446829285Z" level=info msg="using legacy CRI server" Apr 29 23:56:24.447053 containerd[1864]: time="2025-04-29T23:56:24.446895729Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 29 23:56:24.447661 containerd[1864]: time="2025-04-29T23:56:24.447442689Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 29 23:56:24.449404 containerd[1864]: time="2025-04-29T23:56:24.449304777Z" 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" Apr 29 23:56:24.450261 containerd[1864]: time="2025-04-29T23:56:24.450086853Z" level=info msg="Start subscribing containerd event" Apr 29 23:56:24.450261 containerd[1864]: time="2025-04-29T23:56:24.450192381Z" level=info msg="Start recovering state" Apr 29 23:56:24.450628 containerd[1864]: time="2025-04-29T23:56:24.450555297Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 29 23:56:24.452142 containerd[1864]: time="2025-04-29T23:56:24.452076153Z" level=info msg="Start event monitor" Apr 29 23:56:24.452142 containerd[1864]: time="2025-04-29T23:56:24.452137137Z" level=info msg="Start snapshots syncer" Apr 29 23:56:24.452348 containerd[1864]: time="2025-04-29T23:56:24.452165085Z" level=info msg="Start cni network conf syncer for default" Apr 29 23:56:24.452348 containerd[1864]: time="2025-04-29T23:56:24.452187105Z" level=info msg="Start streaming server" Apr 29 23:56:24.454008 containerd[1864]: time="2025-04-29T23:56:24.452537385Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 29 23:56:24.456824 systemd[1]: Started containerd.service - containerd container runtime. Apr 29 23:56:24.463694 containerd[1864]: time="2025-04-29T23:56:24.463630545Z" level=info msg="containerd successfully booted in 0.153205s" Apr 29 23:56:24.650309 systemd-networkd[1696]: eth0: Gained IPv6LL Apr 29 23:56:24.659247 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 29 23:56:24.663806 systemd[1]: Reached target network-online.target - Network is Online. Apr 29 23:56:24.676202 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Apr 29 23:56:24.694486 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 29 23:56:24.753785 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 29 23:56:24.781964 sshd_keygen[1874]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 29 23:56:24.787409 amazon-ssm-agent[2028]: Initializing new seelog logger Apr 29 23:56:24.788091 amazon-ssm-agent[2028]: New Seelog Logger Creation Complete Apr 29 23:56:24.788091 amazon-ssm-agent[2028]: 2025/04/29 23:56:24 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:56:24.788091 amazon-ssm-agent[2028]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:56:24.790852 amazon-ssm-agent[2028]: 2025/04/29 23:56:24 processing appconfig overrides Apr 29 23:56:24.791162 amazon-ssm-agent[2028]: 2025/04/29 23:56:24 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:56:24.791162 amazon-ssm-agent[2028]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:56:24.793036 amazon-ssm-agent[2028]: 2025/04/29 23:56:24 processing appconfig overrides Apr 29 23:56:24.793036 amazon-ssm-agent[2028]: 2025/04/29 23:56:24 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:56:24.793036 amazon-ssm-agent[2028]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:56:24.793036 amazon-ssm-agent[2028]: 2025/04/29 23:56:24 processing appconfig overrides Apr 29 23:56:24.793036 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO Proxy environment variables: Apr 29 23:56:24.800638 amazon-ssm-agent[2028]: 2025/04/29 23:56:24 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:56:24.800638 amazon-ssm-agent[2028]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:56:24.800816 amazon-ssm-agent[2028]: 2025/04/29 23:56:24 processing appconfig overrides Apr 29 23:56:24.834632 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 29 23:56:24.848209 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 29 23:56:24.877206 systemd[1]: issuegen.service: Deactivated successfully. Apr 29 23:56:24.878045 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 29 23:56:24.891441 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 29 23:56:24.896556 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO https_proxy: Apr 29 23:56:24.924114 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 29 23:56:24.937956 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 29 23:56:24.948803 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Apr 29 23:56:24.953681 systemd[1]: Reached target getty.target - Login Prompts. Apr 29 23:56:24.956089 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 29 23:56:24.958935 systemd[1]: Startup finished in 1.108s (kernel) + 7.619s (initrd) + 6.588s (userspace) = 15.315s. Apr 29 23:56:24.994647 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO http_proxy: Apr 29 23:56:25.093488 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO no_proxy: Apr 29 23:56:25.140676 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO Checking if agent identity type OnPrem can be assumed Apr 29 23:56:25.140676 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO Checking if agent identity type EC2 can be assumed Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO Agent will take identity from EC2 Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO [amazon-ssm-agent] Starting Core Agent Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO [amazon-ssm-agent] registrar detected. Attempting registration Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO [Registrar] Starting registrar module Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:24 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:25 INFO [EC2Identity] EC2 registration was successful. Apr 29 23:56:25.140934 amazon-ssm-agent[2028]: 2025-04-29 23:56:25 INFO [CredentialRefresher] credentialRefresher has started Apr 29 23:56:25.141588 amazon-ssm-agent[2028]: 2025-04-29 23:56:25 INFO [CredentialRefresher] Starting credentials refresher loop Apr 29 23:56:25.141588 amazon-ssm-agent[2028]: 2025-04-29 23:56:25 INFO EC2RoleProvider Successfully connected with instance profile role credentials Apr 29 23:56:25.192435 amazon-ssm-agent[2028]: 2025-04-29 23:56:25 INFO [CredentialRefresher] Next credential rotation will be in 30.591652636366668 minutes Apr 29 23:56:25.545248 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 29 23:56:25.556440 systemd[1]: Started sshd@0-172.31.24.163:22-139.178.89.65:54634.service - OpenSSH per-connection server daemon (139.178.89.65:54634). Apr 29 23:56:25.843548 sshd[2064]: Accepted publickey for core from 139.178.89.65 port 54634 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:56:25.848060 sshd-session[2064]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:56:25.871087 systemd-logind[1834]: New session 1 of user core. Apr 29 23:56:25.873420 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 29 23:56:25.886535 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 29 23:56:25.910612 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 29 23:56:25.920620 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 29 23:56:25.937416 (systemd)[2068]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 29 23:56:26.175116 amazon-ssm-agent[2028]: 2025-04-29 23:56:26 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Apr 29 23:56:26.183604 systemd[2068]: Queued start job for default target default.target. Apr 29 23:56:26.195590 systemd[2068]: Created slice app.slice - User Application Slice. Apr 29 23:56:26.195676 systemd[2068]: Reached target paths.target - Paths. Apr 29 23:56:26.195713 systemd[2068]: Reached target timers.target - Timers. Apr 29 23:56:26.207374 systemd[2068]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 29 23:56:26.239069 systemd[2068]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 29 23:56:26.239398 systemd[2068]: Reached target sockets.target - Sockets. Apr 29 23:56:26.239439 systemd[2068]: Reached target basic.target - Basic System. Apr 29 23:56:26.239557 systemd[2068]: Reached target default.target - Main User Target. Apr 29 23:56:26.239631 systemd[2068]: Startup finished in 290ms. Apr 29 23:56:26.239919 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 29 23:56:26.248380 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 29 23:56:26.276181 amazon-ssm-agent[2028]: 2025-04-29 23:56:26 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2075) started Apr 29 23:56:26.378248 amazon-ssm-agent[2028]: 2025-04-29 23:56:26 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Apr 29 23:56:26.472548 systemd[1]: Started sshd@1-172.31.24.163:22-139.178.89.65:54638.service - OpenSSH per-connection server daemon (139.178.89.65:54638). Apr 29 23:56:26.742880 sshd[2091]: Accepted publickey for core from 139.178.89.65 port 54638 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:56:26.746400 sshd-session[2091]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:56:26.757163 systemd-logind[1834]: New session 2 of user core. Apr 29 23:56:26.764345 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 29 23:56:26.939163 sshd[2093]: Connection closed by 139.178.89.65 port 54638 Apr 29 23:56:26.940060 sshd-session[2091]: pam_unix(sshd:session): session closed for user core Apr 29 23:56:26.946423 systemd[1]: sshd@1-172.31.24.163:22-139.178.89.65:54638.service: Deactivated successfully. Apr 29 23:56:26.950209 systemd[1]: session-2.scope: Deactivated successfully. Apr 29 23:56:26.951597 systemd-logind[1834]: Session 2 logged out. Waiting for processes to exit. Apr 29 23:56:26.953889 systemd-logind[1834]: Removed session 2. Apr 29 23:56:26.990563 systemd[1]: Started sshd@2-172.31.24.163:22-139.178.89.65:55340.service - OpenSSH per-connection server daemon (139.178.89.65:55340). Apr 29 23:56:27.267580 sshd[2098]: Accepted publickey for core from 139.178.89.65 port 55340 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:56:27.270333 sshd-session[2098]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:56:27.279097 systemd-logind[1834]: New session 3 of user core. Apr 29 23:56:27.290329 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 29 23:56:27.410443 ntpd[1830]: Listen normally on 7 eth0 [fe80::480:dfff:fe60:a70b%2]:123 Apr 29 23:56:27.411102 ntpd[1830]: 29 Apr 23:56:27 ntpd[1830]: Listen normally on 7 eth0 [fe80::480:dfff:fe60:a70b%2]:123 Apr 29 23:56:27.457181 sshd[2100]: Connection closed by 139.178.89.65 port 55340 Apr 29 23:56:27.458113 sshd-session[2098]: pam_unix(sshd:session): session closed for user core Apr 29 23:56:27.464729 systemd[1]: sshd@2-172.31.24.163:22-139.178.89.65:55340.service: Deactivated successfully. Apr 29 23:56:27.470067 systemd[1]: session-3.scope: Deactivated successfully. Apr 29 23:56:27.471294 systemd-logind[1834]: Session 3 logged out. Waiting for processes to exit. Apr 29 23:56:27.473763 systemd-logind[1834]: Removed session 3. Apr 29 23:56:27.512527 systemd[1]: Started sshd@3-172.31.24.163:22-139.178.89.65:55342.service - OpenSSH per-connection server daemon (139.178.89.65:55342). Apr 29 23:56:27.794296 sshd[2105]: Accepted publickey for core from 139.178.89.65 port 55342 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:56:27.797237 sshd-session[2105]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:56:27.806554 systemd-logind[1834]: New session 4 of user core. Apr 29 23:56:27.815340 systemd[1]: Started session-4.scope - Session 4 of User core. Apr 29 23:56:27.996404 sshd[2107]: Connection closed by 139.178.89.65 port 55342 Apr 29 23:56:27.997255 sshd-session[2105]: pam_unix(sshd:session): session closed for user core Apr 29 23:56:28.008332 systemd[1]: sshd@3-172.31.24.163:22-139.178.89.65:55342.service: Deactivated successfully. Apr 29 23:56:28.014775 systemd[1]: session-4.scope: Deactivated successfully. Apr 29 23:56:28.016438 systemd-logind[1834]: Session 4 logged out. Waiting for processes to exit. Apr 29 23:56:28.019246 systemd-logind[1834]: Removed session 4. Apr 29 23:56:28.050529 systemd[1]: Started sshd@4-172.31.24.163:22-139.178.89.65:55344.service - OpenSSH per-connection server daemon (139.178.89.65:55344). Apr 29 23:56:28.325965 sshd[2112]: Accepted publickey for core from 139.178.89.65 port 55344 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:56:28.328472 sshd-session[2112]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:56:28.336795 systemd-logind[1834]: New session 5 of user core. Apr 29 23:56:28.345304 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 29 23:56:28.501787 sudo[2115]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Apr 29 23:56:28.503435 sudo[2115]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:56:28.522243 sudo[2115]: pam_unix(sudo:session): session closed for user root Apr 29 23:56:28.560160 sshd[2114]: Connection closed by 139.178.89.65 port 55344 Apr 29 23:56:28.561757 sshd-session[2112]: pam_unix(sshd:session): session closed for user core Apr 29 23:56:28.570845 systemd[1]: sshd@4-172.31.24.163:22-139.178.89.65:55344.service: Deactivated successfully. Apr 29 23:56:28.575390 systemd[1]: session-5.scope: Deactivated successfully. Apr 29 23:56:28.576964 systemd-logind[1834]: Session 5 logged out. Waiting for processes to exit. Apr 29 23:56:28.580728 systemd-logind[1834]: Removed session 5. Apr 29 23:56:28.619539 systemd[1]: Started sshd@5-172.31.24.163:22-139.178.89.65:55350.service - OpenSSH per-connection server daemon (139.178.89.65:55350). Apr 29 23:56:28.886758 sshd[2120]: Accepted publickey for core from 139.178.89.65 port 55350 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:56:28.889443 sshd-session[2120]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:56:28.897086 systemd-logind[1834]: New session 6 of user core. Apr 29 23:56:28.908277 systemd[1]: Started session-6.scope - Session 6 of User core. Apr 29 23:56:29.047941 sudo[2124]: 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 Apr 29 23:56:29.049329 sudo[2124]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:56:29.057077 sudo[2124]: pam_unix(sudo:session): session closed for user root Apr 29 23:56:29.069103 sudo[2123]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Apr 29 23:56:29.069944 sudo[2123]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:56:29.101664 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 29 23:56:29.159349 augenrules[2146]: No rules Apr 29 23:56:29.162923 systemd[1]: audit-rules.service: Deactivated successfully. Apr 29 23:56:29.163421 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 29 23:56:29.166581 sudo[2123]: pam_unix(sudo:session): session closed for user root Apr 29 23:56:29.204213 sshd[2122]: Connection closed by 139.178.89.65 port 55350 Apr 29 23:56:29.205382 sshd-session[2120]: pam_unix(sshd:session): session closed for user core Apr 29 23:56:29.213550 systemd[1]: sshd@5-172.31.24.163:22-139.178.89.65:55350.service: Deactivated successfully. Apr 29 23:56:29.218392 systemd[1]: session-6.scope: Deactivated successfully. Apr 29 23:56:29.220498 systemd-logind[1834]: Session 6 logged out. Waiting for processes to exit. Apr 29 23:56:29.222945 systemd-logind[1834]: Removed session 6. Apr 29 23:56:29.262591 systemd[1]: Started sshd@6-172.31.24.163:22-139.178.89.65:55360.service - OpenSSH per-connection server daemon (139.178.89.65:55360). Apr 29 23:56:29.532559 sshd[2154]: Accepted publickey for core from 139.178.89.65 port 55360 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:56:29.535396 sshd-session[2154]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:56:29.543784 systemd-logind[1834]: New session 7 of user core. Apr 29 23:56:29.555299 systemd[1]: Started session-7.scope - Session 7 of User core. Apr 29 23:56:29.693941 sudo[2157]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/cat /var/resource/http Apr 29 23:56:29.694681 sudo[2157]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:56:29.701498 sudo[2157]: pam_unix(sudo:session): session closed for user root Apr 29 23:56:29.739064 sshd[2156]: Connection closed by 139.178.89.65 port 55360 Apr 29 23:56:29.740023 sshd-session[2154]: pam_unix(sshd:session): session closed for user core Apr 29 23:56:29.747720 systemd[1]: sshd@6-172.31.24.163:22-139.178.89.65:55360.service: Deactivated successfully. Apr 29 23:56:29.752212 systemd[1]: session-7.scope: Deactivated successfully. Apr 29 23:56:29.753743 systemd-logind[1834]: Session 7 logged out. Waiting for processes to exit. Apr 29 23:56:29.757541 systemd-logind[1834]: Removed session 7. Apr 29 23:56:29.793517 systemd[1]: Started sshd@7-172.31.24.163:22-139.178.89.65:55364.service - OpenSSH per-connection server daemon (139.178.89.65:55364). Apr 29 23:56:30.075928 sshd[2162]: Accepted publickey for core from 139.178.89.65 port 55364 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:56:30.078927 sshd-session[2162]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:56:30.090436 systemd-logind[1834]: New session 8 of user core. Apr 29 23:56:30.094327 systemd[1]: Started session-8.scope - Session 8 of User core. Apr 29 23:56:30.237867 sudo[2165]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/cat /var/resource/https Apr 29 23:56:30.238741 sudo[2165]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:56:30.245273 sudo[2165]: pam_unix(sudo:session): session closed for user root Apr 29 23:56:30.283056 sshd[2164]: Connection closed by 139.178.89.65 port 55364 Apr 29 23:56:30.284007 sshd-session[2162]: pam_unix(sshd:session): session closed for user core Apr 29 23:56:30.290872 systemd-logind[1834]: Session 8 logged out. Waiting for processes to exit. Apr 29 23:56:30.291321 systemd[1]: sshd@7-172.31.24.163:22-139.178.89.65:55364.service: Deactivated successfully. Apr 29 23:56:30.295232 systemd[1]: session-8.scope: Deactivated successfully. Apr 29 23:56:30.299938 systemd-logind[1834]: Removed session 8. Apr 29 23:56:30.343545 systemd[1]: Started sshd@8-172.31.24.163:22-139.178.89.65:55366.service - OpenSSH per-connection server daemon (139.178.89.65:55366). Apr 29 23:56:30.068150 systemd-resolved[1644]: Clock change detected. Flushing caches. Apr 29 23:56:30.075052 systemd-journald[1483]: Time jumped backwards, rotating. Apr 29 23:56:30.275919 sshd[2170]: Accepted publickey for core from 139.178.89.65 port 55366 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:56:30.278798 sshd-session[2170]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:56:30.287540 systemd-logind[1834]: New session 9 of user core. Apr 29 23:56:30.298760 systemd[1]: Started session-9.scope - Session 9 of User core. Apr 29 23:56:30.438516 sudo[2174]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/cat /var/resource/s3-anon Apr 29 23:56:30.439201 sudo[2174]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:56:30.447177 sudo[2174]: pam_unix(sudo:session): session closed for user root Apr 29 23:56:30.487105 sshd[2173]: Connection closed by 139.178.89.65 port 55366 Apr 29 23:56:30.485847 sshd-session[2170]: pam_unix(sshd:session): session closed for user core Apr 29 23:56:30.492819 systemd[1]: sshd@8-172.31.24.163:22-139.178.89.65:55366.service: Deactivated successfully. Apr 29 23:56:30.497530 systemd[1]: session-9.scope: Deactivated successfully. Apr 29 23:56:30.500124 systemd-logind[1834]: Session 9 logged out. Waiting for processes to exit. Apr 29 23:56:30.502355 systemd-logind[1834]: Removed session 9.