Apr 29 23:55:19.200868 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Apr 29 23:55:19.200913 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:55:19.200938 kernel: KASLR disabled due to lack of seed Apr 29 23:55:19.200954 kernel: efi: EFI v2.7 by EDK II Apr 29 23:55:19.200970 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b003a98 MEMRESERVE=0x78503d98 Apr 29 23:55:19.200985 kernel: secureboot: Secure boot disabled Apr 29 23:55:19.201002 kernel: ACPI: Early table checksum verification disabled Apr 29 23:55:19.201017 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Apr 29 23:55:19.201033 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Apr 29 23:55:19.201048 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Apr 29 23:55:19.201067 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Apr 29 23:55:19.201100 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Apr 29 23:55:19.201121 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Apr 29 23:55:19.201138 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Apr 29 23:55:19.201158 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Apr 29 23:55:19.201182 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Apr 29 23:55:19.201200 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Apr 29 23:55:19.201218 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Apr 29 23:55:19.201236 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Apr 29 23:55:19.201253 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Apr 29 23:55:19.201270 kernel: printk: bootconsole [uart0] enabled Apr 29 23:55:19.201287 kernel: NUMA: Failed to initialise from firmware Apr 29 23:55:19.201304 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Apr 29 23:55:19.201321 kernel: NUMA: NODE_DATA [mem 0x4b5840800-0x4b5845fff] Apr 29 23:55:19.201338 kernel: Zone ranges: Apr 29 23:55:19.201354 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Apr 29 23:55:19.201376 kernel: DMA32 empty Apr 29 23:55:19.201393 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Apr 29 23:55:19.201410 kernel: Movable zone start for each node Apr 29 23:55:19.201426 kernel: Early memory node ranges Apr 29 23:55:19.201443 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Apr 29 23:55:19.201460 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Apr 29 23:55:19.201476 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Apr 29 23:55:19.201493 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Apr 29 23:55:19.201509 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Apr 29 23:55:19.201525 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Apr 29 23:55:19.201542 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Apr 29 23:55:19.201558 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Apr 29 23:55:19.201578 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Apr 29 23:55:19.201595 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Apr 29 23:55:19.201617 kernel: psci: probing for conduit method from ACPI. Apr 29 23:55:19.201634 kernel: psci: PSCIv1.0 detected in firmware. Apr 29 23:55:19.201651 kernel: psci: Using standard PSCI v0.2 function IDs Apr 29 23:55:19.201672 kernel: psci: Trusted OS migration not required Apr 29 23:55:19.201690 kernel: psci: SMC Calling Convention v1.1 Apr 29 23:55:19.201707 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Apr 29 23:55:19.201724 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Apr 29 23:55:19.201741 kernel: pcpu-alloc: [0] 0 [0] 1 Apr 29 23:55:19.201758 kernel: Detected PIPT I-cache on CPU0 Apr 29 23:55:19.201775 kernel: CPU features: detected: GIC system register CPU interface Apr 29 23:55:19.201792 kernel: CPU features: detected: Spectre-v2 Apr 29 23:55:19.203036 kernel: CPU features: detected: Spectre-v3a Apr 29 23:55:19.203076 kernel: CPU features: detected: Spectre-BHB Apr 29 23:55:19.203095 kernel: CPU features: detected: ARM erratum 1742098 Apr 29 23:55:19.203113 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Apr 29 23:55:19.203140 kernel: alternatives: applying boot alternatives Apr 29 23:55:19.203160 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:55:19.203179 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Apr 29 23:55:19.203196 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 29 23:55:19.203214 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 29 23:55:19.203231 kernel: Fallback order for Node 0: 0 Apr 29 23:55:19.203249 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Apr 29 23:55:19.203266 kernel: Policy zone: Normal Apr 29 23:55:19.203283 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 29 23:55:19.203300 kernel: software IO TLB: area num 2. Apr 29 23:55:19.203321 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Apr 29 23:55:19.203340 kernel: Memory: 3819836K/4030464K available (10304K kernel code, 2186K rwdata, 8104K rodata, 39744K init, 897K bss, 210628K reserved, 0K cma-reserved) Apr 29 23:55:19.203357 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Apr 29 23:55:19.203374 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 29 23:55:19.203392 kernel: rcu: RCU event tracing is enabled. Apr 29 23:55:19.203409 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Apr 29 23:55:19.203427 kernel: Trampoline variant of Tasks RCU enabled. Apr 29 23:55:19.203444 kernel: Tracing variant of Tasks RCU enabled. Apr 29 23:55:19.203461 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 29 23:55:19.203478 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Apr 29 23:55:19.203495 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Apr 29 23:55:19.203516 kernel: GICv3: 96 SPIs implemented Apr 29 23:55:19.203533 kernel: GICv3: 0 Extended SPIs implemented Apr 29 23:55:19.203550 kernel: Root IRQ handler: gic_handle_irq Apr 29 23:55:19.203566 kernel: GICv3: GICv3 features: 16 PPIs Apr 29 23:55:19.203583 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Apr 29 23:55:19.203600 kernel: ITS [mem 0x10080000-0x1009ffff] Apr 29 23:55:19.203617 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Apr 29 23:55:19.203635 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Apr 29 23:55:19.203652 kernel: GICv3: using LPI property table @0x00000004000d0000 Apr 29 23:55:19.203669 kernel: ITS: Using hypervisor restricted LPI range [128] Apr 29 23:55:19.203686 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Apr 29 23:55:19.203703 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 29 23:55:19.203724 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Apr 29 23:55:19.203741 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Apr 29 23:55:19.203759 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Apr 29 23:55:19.203776 kernel: Console: colour dummy device 80x25 Apr 29 23:55:19.203794 kernel: printk: console [tty1] enabled Apr 29 23:55:19.203835 kernel: ACPI: Core revision 20230628 Apr 29 23:55:19.203853 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Apr 29 23:55:19.203872 kernel: pid_max: default: 32768 minimum: 301 Apr 29 23:55:19.203889 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Apr 29 23:55:19.203906 kernel: landlock: Up and running. Apr 29 23:55:19.203931 kernel: SELinux: Initializing. Apr 29 23:55:19.203948 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 29 23:55:19.203966 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 29 23:55:19.203984 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Apr 29 23:55:19.204001 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:55:19.204019 kernel: rcu: Hierarchical SRCU implementation. Apr 29 23:55:19.204036 kernel: rcu: Max phase no-delay instances is 400. Apr 29 23:55:19.204054 kernel: Platform MSI: ITS@0x10080000 domain created Apr 29 23:55:19.204075 kernel: PCI/MSI: ITS@0x10080000 domain created Apr 29 23:55:19.204094 kernel: Remapping and enabling EFI services. Apr 29 23:55:19.204113 kernel: smp: Bringing up secondary CPUs ... Apr 29 23:55:19.204130 kernel: Detected PIPT I-cache on CPU1 Apr 29 23:55:19.204148 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Apr 29 23:55:19.204166 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Apr 29 23:55:19.204185 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Apr 29 23:55:19.204202 kernel: smp: Brought up 1 node, 2 CPUs Apr 29 23:55:19.204219 kernel: SMP: Total of 2 processors activated. Apr 29 23:55:19.204237 kernel: CPU features: detected: 32-bit EL0 Support Apr 29 23:55:19.204259 kernel: CPU features: detected: 32-bit EL1 Support Apr 29 23:55:19.204277 kernel: CPU features: detected: CRC32 instructions Apr 29 23:55:19.204305 kernel: CPU: All CPU(s) started at EL1 Apr 29 23:55:19.204328 kernel: alternatives: applying system-wide alternatives Apr 29 23:55:19.204345 kernel: devtmpfs: initialized Apr 29 23:55:19.204364 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 29 23:55:19.204382 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Apr 29 23:55:19.204399 kernel: pinctrl core: initialized pinctrl subsystem Apr 29 23:55:19.204418 kernel: SMBIOS 3.0.0 present. Apr 29 23:55:19.204440 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Apr 29 23:55:19.204458 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 29 23:55:19.204476 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Apr 29 23:55:19.204495 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Apr 29 23:55:19.204513 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Apr 29 23:55:19.204531 kernel: audit: initializing netlink subsys (disabled) Apr 29 23:55:19.204549 kernel: audit: type=2000 audit(0.219:1): state=initialized audit_enabled=0 res=1 Apr 29 23:55:19.204571 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 29 23:55:19.204590 kernel: cpuidle: using governor menu Apr 29 23:55:19.204608 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Apr 29 23:55:19.204627 kernel: ASID allocator initialised with 65536 entries Apr 29 23:55:19.204645 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 29 23:55:19.204663 kernel: Serial: AMBA PL011 UART driver Apr 29 23:55:19.204681 kernel: Modules: 17408 pages in range for non-PLT usage Apr 29 23:55:19.204700 kernel: Modules: 508928 pages in range for PLT usage Apr 29 23:55:19.204718 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 29 23:55:19.204740 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Apr 29 23:55:19.204759 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Apr 29 23:55:19.204777 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Apr 29 23:55:19.204796 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 29 23:55:19.205374 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Apr 29 23:55:19.205395 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Apr 29 23:55:19.205413 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Apr 29 23:55:19.205432 kernel: ACPI: Added _OSI(Module Device) Apr 29 23:55:19.205450 kernel: ACPI: Added _OSI(Processor Device) Apr 29 23:55:19.205477 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Apr 29 23:55:19.205498 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 29 23:55:19.205517 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 29 23:55:19.205535 kernel: ACPI: Interpreter enabled Apr 29 23:55:19.205553 kernel: ACPI: Using GIC for interrupt routing Apr 29 23:55:19.205572 kernel: ACPI: MCFG table detected, 1 entries Apr 29 23:55:19.205590 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Apr 29 23:55:19.205966 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 29 23:55:19.206213 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Apr 29 23:55:19.206436 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Apr 29 23:55:19.206642 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Apr 29 23:55:19.207363 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Apr 29 23:55:19.207401 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Apr 29 23:55:19.207421 kernel: acpiphp: Slot [1] registered Apr 29 23:55:19.207440 kernel: acpiphp: Slot [2] registered Apr 29 23:55:19.207458 kernel: acpiphp: Slot [3] registered Apr 29 23:55:19.207485 kernel: acpiphp: Slot [4] registered Apr 29 23:55:19.207504 kernel: acpiphp: Slot [5] registered Apr 29 23:55:19.207522 kernel: acpiphp: Slot [6] registered Apr 29 23:55:19.207540 kernel: acpiphp: Slot [7] registered Apr 29 23:55:19.207557 kernel: acpiphp: Slot [8] registered Apr 29 23:55:19.207575 kernel: acpiphp: Slot [9] registered Apr 29 23:55:19.207593 kernel: acpiphp: Slot [10] registered Apr 29 23:55:19.207611 kernel: acpiphp: Slot [11] registered Apr 29 23:55:19.207629 kernel: acpiphp: Slot [12] registered Apr 29 23:55:19.207646 kernel: acpiphp: Slot [13] registered Apr 29 23:55:19.207669 kernel: acpiphp: Slot [14] registered Apr 29 23:55:19.207686 kernel: acpiphp: Slot [15] registered Apr 29 23:55:19.207704 kernel: acpiphp: Slot [16] registered Apr 29 23:55:19.207722 kernel: acpiphp: Slot [17] registered Apr 29 23:55:19.207740 kernel: acpiphp: Slot [18] registered Apr 29 23:55:19.207758 kernel: acpiphp: Slot [19] registered Apr 29 23:55:19.207776 kernel: acpiphp: Slot [20] registered Apr 29 23:55:19.207794 kernel: acpiphp: Slot [21] registered Apr 29 23:55:19.207839 kernel: acpiphp: Slot [22] registered Apr 29 23:55:19.207867 kernel: acpiphp: Slot [23] registered Apr 29 23:55:19.207886 kernel: acpiphp: Slot [24] registered Apr 29 23:55:19.207904 kernel: acpiphp: Slot [25] registered Apr 29 23:55:19.207922 kernel: acpiphp: Slot [26] registered Apr 29 23:55:19.207940 kernel: acpiphp: Slot [27] registered Apr 29 23:55:19.207958 kernel: acpiphp: Slot [28] registered Apr 29 23:55:19.207976 kernel: acpiphp: Slot [29] registered Apr 29 23:55:19.207994 kernel: acpiphp: Slot [30] registered Apr 29 23:55:19.208012 kernel: acpiphp: Slot [31] registered Apr 29 23:55:19.208030 kernel: PCI host bridge to bus 0000:00 Apr 29 23:55:19.208364 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Apr 29 23:55:19.211024 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Apr 29 23:55:19.211261 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Apr 29 23:55:19.211448 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Apr 29 23:55:19.211685 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Apr 29 23:55:19.211978 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Apr 29 23:55:19.212193 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Apr 29 23:55:19.212403 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Apr 29 23:55:19.212601 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Apr 29 23:55:19.212905 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Apr 29 23:55:19.216052 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Apr 29 23:55:19.216282 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Apr 29 23:55:19.216489 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Apr 29 23:55:19.216699 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Apr 29 23:55:19.217538 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Apr 29 23:55:19.217753 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Apr 29 23:55:19.217989 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Apr 29 23:55:19.218196 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Apr 29 23:55:19.218394 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Apr 29 23:55:19.218596 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Apr 29 23:55:19.218787 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Apr 29 23:55:19.219959 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Apr 29 23:55:19.220155 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Apr 29 23:55:19.220183 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Apr 29 23:55:19.220203 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Apr 29 23:55:19.220224 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Apr 29 23:55:19.220242 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Apr 29 23:55:19.220265 kernel: iommu: Default domain type: Translated Apr 29 23:55:19.220297 kernel: iommu: DMA domain TLB invalidation policy: strict mode Apr 29 23:55:19.220316 kernel: efivars: Registered efivars operations Apr 29 23:55:19.220334 kernel: vgaarb: loaded Apr 29 23:55:19.220354 kernel: clocksource: Switched to clocksource arch_sys_counter Apr 29 23:55:19.220372 kernel: VFS: Disk quotas dquot_6.6.0 Apr 29 23:55:19.220391 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 29 23:55:19.220409 kernel: pnp: PnP ACPI init Apr 29 23:55:19.220628 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Apr 29 23:55:19.220661 kernel: pnp: PnP ACPI: found 1 devices Apr 29 23:55:19.220681 kernel: NET: Registered PF_INET protocol family Apr 29 23:55:19.220700 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 29 23:55:19.220719 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Apr 29 23:55:19.220738 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 29 23:55:19.220758 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Apr 29 23:55:19.220779 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Apr 29 23:55:19.220819 kernel: TCP: Hash tables configured (established 32768 bind 32768) Apr 29 23:55:19.220875 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 29 23:55:19.220901 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 29 23:55:19.220920 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 29 23:55:19.220938 kernel: PCI: CLS 0 bytes, default 64 Apr 29 23:55:19.220956 kernel: kvm [1]: HYP mode not available Apr 29 23:55:19.220975 kernel: Initialise system trusted keyrings Apr 29 23:55:19.220994 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Apr 29 23:55:19.221012 kernel: Key type asymmetric registered Apr 29 23:55:19.221030 kernel: Asymmetric key parser 'x509' registered Apr 29 23:55:19.221051 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Apr 29 23:55:19.221075 kernel: io scheduler mq-deadline registered Apr 29 23:55:19.221114 kernel: io scheduler kyber registered Apr 29 23:55:19.221134 kernel: io scheduler bfq registered Apr 29 23:55:19.221365 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Apr 29 23:55:19.221393 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Apr 29 23:55:19.221411 kernel: ACPI: button: Power Button [PWRB] Apr 29 23:55:19.221430 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Apr 29 23:55:19.221448 kernel: ACPI: button: Sleep Button [SLPB] Apr 29 23:55:19.221472 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 29 23:55:19.221492 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Apr 29 23:55:19.221705 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Apr 29 23:55:19.221732 kernel: printk: console [ttyS0] disabled Apr 29 23:55:19.221751 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Apr 29 23:55:19.221770 kernel: printk: console [ttyS0] enabled Apr 29 23:55:19.221789 kernel: printk: bootconsole [uart0] disabled Apr 29 23:55:19.221953 kernel: thunder_xcv, ver 1.0 Apr 29 23:55:19.221978 kernel: thunder_bgx, ver 1.0 Apr 29 23:55:19.221997 kernel: nicpf, ver 1.0 Apr 29 23:55:19.222025 kernel: nicvf, ver 1.0 Apr 29 23:55:19.222252 kernel: rtc-efi rtc-efi.0: registered as rtc0 Apr 29 23:55:19.222442 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-04-29T23:55:18 UTC (1745970918) Apr 29 23:55:19.222469 kernel: hid: raw HID events driver (C) Jiri Kosina Apr 29 23:55:19.222490 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Apr 29 23:55:19.222510 kernel: watchdog: Delayed init of the lockup detector failed: -19 Apr 29 23:55:19.222530 kernel: watchdog: Hard watchdog permanently disabled Apr 29 23:55:19.222555 kernel: NET: Registered PF_INET6 protocol family Apr 29 23:55:19.222575 kernel: Segment Routing with IPv6 Apr 29 23:55:19.222593 kernel: In-situ OAM (IOAM) with IPv6 Apr 29 23:55:19.222611 kernel: NET: Registered PF_PACKET protocol family Apr 29 23:55:19.222629 kernel: Key type dns_resolver registered Apr 29 23:55:19.222647 kernel: registered taskstats version 1 Apr 29 23:55:19.222665 kernel: Loading compiled-in X.509 certificates Apr 29 23:55:19.222683 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.88-flatcar: bbef389676bd9584646af24e9e264c7789f8630f' Apr 29 23:55:19.222702 kernel: Key type .fscrypt registered Apr 29 23:55:19.222720 kernel: Key type fscrypt-provisioning registered Apr 29 23:55:19.222743 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 29 23:55:19.222761 kernel: ima: Allocated hash algorithm: sha1 Apr 29 23:55:19.222779 kernel: ima: No architecture policies found Apr 29 23:55:19.222797 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Apr 29 23:55:19.222858 kernel: clk: Disabling unused clocks Apr 29 23:55:19.222877 kernel: Freeing unused kernel memory: 39744K Apr 29 23:55:19.222895 kernel: Run /init as init process Apr 29 23:55:19.222914 kernel: with arguments: Apr 29 23:55:19.222932 kernel: /init Apr 29 23:55:19.222956 kernel: with environment: Apr 29 23:55:19.222974 kernel: HOME=/ Apr 29 23:55:19.222992 kernel: TERM=linux Apr 29 23:55:19.223009 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Apr 29 23:55:19.223032 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:55:19.223054 systemd[1]: Detected virtualization amazon. Apr 29 23:55:19.223074 systemd[1]: Detected architecture arm64. Apr 29 23:55:19.223098 systemd[1]: Running in initrd. Apr 29 23:55:19.223117 systemd[1]: No hostname configured, using default hostname. Apr 29 23:55:19.223136 systemd[1]: Hostname set to . Apr 29 23:55:19.223156 systemd[1]: Initializing machine ID from VM UUID. Apr 29 23:55:19.223176 systemd[1]: Queued start job for default target initrd.target. Apr 29 23:55:19.223195 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 29 23:55:19.223215 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 29 23:55:19.223235 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 29 23:55:19.223259 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 29 23:55:19.223280 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 29 23:55:19.223300 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 29 23:55:19.223322 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:55:19.223343 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Apr 29 23:55:19.223363 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 29 23:55:19.223382 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 29 23:55:19.223406 systemd[1]: Reached target paths.target - Path Units. Apr 29 23:55:19.223426 systemd[1]: Reached target slices.target - Slice Units. Apr 29 23:55:19.223446 systemd[1]: Reached target swap.target - Swaps. Apr 29 23:55:19.223465 systemd[1]: Reached target timers.target - Timer Units. Apr 29 23:55:19.223485 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 29 23:55:19.223505 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 29 23:55:19.223524 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 29 23:55:19.223544 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Apr 29 23:55:19.223563 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 29 23:55:19.223588 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 29 23:55:19.223607 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 29 23:55:19.223627 systemd[1]: Reached target sockets.target - Socket Units. Apr 29 23:55:19.223646 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 29 23:55:19.223666 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 29 23:55:19.223685 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 29 23:55:19.223705 systemd[1]: Starting systemd-fsck-usr.service... Apr 29 23:55:19.223724 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 29 23:55:19.223750 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 29 23:55:19.223771 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:55:19.223791 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 29 23:55:19.225888 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 29 23:55:19.225917 systemd[1]: Finished systemd-fsck-usr.service. Apr 29 23:55:19.225982 systemd-journald[252]: Collecting audit messages is disabled. Apr 29 23:55:19.226035 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 29 23:55:19.226057 systemd-journald[252]: Journal started Apr 29 23:55:19.226098 systemd-journald[252]: Runtime Journal (/run/log/journal/ec224dbaa0a0b0113a56eb94829ade08) is 8.0M, max 75.3M, 67.3M free. Apr 29 23:55:19.211137 systemd-modules-load[253]: Inserted module 'overlay' Apr 29 23:55:19.229269 systemd[1]: Started systemd-journald.service - Journal Service. Apr 29 23:55:19.240933 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:55:19.248948 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 29 23:55:19.259177 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:55:19.261951 systemd-modules-load[253]: Inserted module 'br_netfilter' Apr 29 23:55:19.264062 kernel: Bridge firewalling registered Apr 29 23:55:19.269280 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 29 23:55:19.284498 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 29 23:55:19.292114 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 29 23:55:19.295155 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 29 23:55:19.316452 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 29 23:55:19.330899 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 29 23:55:19.345926 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 29 23:55:19.365210 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:55:19.379291 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 29 23:55:19.389212 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 29 23:55:19.403465 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 29 23:55:19.434556 dracut-cmdline[288]: dracut-dracut-053 Apr 29 23:55:19.444345 dracut-cmdline[288]: 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:55:19.498174 systemd-resolved[289]: Positive Trust Anchors: Apr 29 23:55:19.498254 systemd-resolved[289]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 29 23:55:19.498317 systemd-resolved[289]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Apr 29 23:55:19.599841 kernel: SCSI subsystem initialized Apr 29 23:55:19.606832 kernel: Loading iSCSI transport class v2.0-870. Apr 29 23:55:19.619841 kernel: iscsi: registered transport (tcp) Apr 29 23:55:19.643360 kernel: iscsi: registered transport (qla4xxx) Apr 29 23:55:19.643434 kernel: QLogic iSCSI HBA Driver Apr 29 23:55:19.731849 kernel: random: crng init done Apr 29 23:55:19.732367 systemd-resolved[289]: Defaulting to hostname 'linux'. Apr 29 23:55:19.736244 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 29 23:55:19.740797 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 29 23:55:19.766054 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 29 23:55:19.778147 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 29 23:55:19.822179 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 29 23:55:19.822254 kernel: device-mapper: uevent: version 1.0.3 Apr 29 23:55:19.822280 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Apr 29 23:55:19.891845 kernel: raid6: neonx8 gen() 6750 MB/s Apr 29 23:55:19.908834 kernel: raid6: neonx4 gen() 6553 MB/s Apr 29 23:55:19.925846 kernel: raid6: neonx2 gen() 5484 MB/s Apr 29 23:55:19.942835 kernel: raid6: neonx1 gen() 3958 MB/s Apr 29 23:55:19.959835 kernel: raid6: int64x8 gen() 3821 MB/s Apr 29 23:55:19.976834 kernel: raid6: int64x4 gen() 3713 MB/s Apr 29 23:55:19.993842 kernel: raid6: int64x2 gen() 3612 MB/s Apr 29 23:55:20.011666 kernel: raid6: int64x1 gen() 2768 MB/s Apr 29 23:55:20.011702 kernel: raid6: using algorithm neonx8 gen() 6750 MB/s Apr 29 23:55:20.029653 kernel: raid6: .... xor() 4888 MB/s, rmw enabled Apr 29 23:55:20.029707 kernel: raid6: using neon recovery algorithm Apr 29 23:55:20.037843 kernel: xor: measuring software checksum speed Apr 29 23:55:20.037906 kernel: 8regs : 10159 MB/sec Apr 29 23:55:20.041089 kernel: 32regs : 10875 MB/sec Apr 29 23:55:20.041124 kernel: arm64_neon : 9551 MB/sec Apr 29 23:55:20.041159 kernel: xor: using function: 32regs (10875 MB/sec) Apr 29 23:55:20.126873 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 29 23:55:20.147464 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 29 23:55:20.157150 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 29 23:55:20.200824 systemd-udevd[471]: Using default interface naming scheme 'v255'. Apr 29 23:55:20.210870 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 29 23:55:20.226052 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 29 23:55:20.257996 dracut-pre-trigger[475]: rd.md=0: removing MD RAID activation Apr 29 23:55:20.318640 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 29 23:55:20.329163 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 29 23:55:20.461958 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 29 23:55:20.475228 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 29 23:55:20.530176 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 29 23:55:20.535267 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 29 23:55:20.538101 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 29 23:55:20.540394 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 29 23:55:20.555358 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 29 23:55:20.611165 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 29 23:55:20.684305 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Apr 29 23:55:20.684376 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Apr 29 23:55:20.707414 kernel: ena 0000:00:05.0: ENA device version: 0.10 Apr 29 23:55:20.707681 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Apr 29 23:55:20.707956 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:62:ff:38:a8:b9 Apr 29 23:55:20.705948 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 29 23:55:20.706189 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:55:20.710609 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 29 23:55:20.714538 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 29 23:55:20.715061 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:55:20.722836 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:55:20.752703 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Apr 29 23:55:20.755944 kernel: nvme nvme0: pci function 0000:00:04.0 Apr 29 23:55:20.753268 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:55:20.765852 kernel: nvme nvme0: 2/0/0 default/read/poll queues Apr 29 23:55:20.777305 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Apr 29 23:55:20.777376 kernel: GPT:9289727 != 16777215 Apr 29 23:55:20.777411 kernel: GPT:Alternate GPT header not at the end of the disk. Apr 29 23:55:20.778209 kernel: GPT:9289727 != 16777215 Apr 29 23:55:20.779328 kernel: GPT: Use GNU Parted to correct GPT errors. Apr 29 23:55:20.779371 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 29 23:55:20.787353 (udev-worker)[526]: Network interface NamePolicy= disabled on kernel command line. Apr 29 23:55:20.792180 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:55:20.803289 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 29 23:55:20.862345 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:55:20.903976 kernel: BTRFS: device fsid 9647859b-527c-478f-8aa1-9dfa3fa871e3 devid 1 transid 43 /dev/nvme0n1p3 scanned by (udev-worker) (528) Apr 29 23:55:20.944382 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Apr 29 23:55:20.968541 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Apr 29 23:55:20.976934 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by (udev-worker) (518) Apr 29 23:55:20.977134 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Apr 29 23:55:20.995242 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 29 23:55:21.022034 disk-uuid[632]: Primary Header is updated. Apr 29 23:55:21.022034 disk-uuid[632]: Secondary Entries is updated. Apr 29 23:55:21.022034 disk-uuid[632]: Secondary Header is updated. Apr 29 23:55:21.082740 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Apr 29 23:55:21.122756 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Apr 29 23:55:22.047938 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 29 23:55:22.051633 disk-uuid[638]: The operation has completed successfully. Apr 29 23:55:22.254449 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 29 23:55:22.254704 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 29 23:55:22.310058 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Apr 29 23:55:22.318796 sh[925]: Success Apr 29 23:55:22.358863 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Apr 29 23:55:22.542792 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Apr 29 23:55:22.567047 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Apr 29 23:55:22.574077 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Apr 29 23:55:22.615768 kernel: BTRFS info (device dm-0): first mount of filesystem 9647859b-527c-478f-8aa1-9dfa3fa871e3 Apr 29 23:55:22.615927 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:55:22.615958 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Apr 29 23:55:22.618838 kernel: BTRFS info (device dm-0): disabling log replay at mount time Apr 29 23:55:22.618902 kernel: BTRFS info (device dm-0): using free space tree Apr 29 23:55:22.670836 kernel: BTRFS info (device dm-0): enabling ssd optimizations Apr 29 23:55:22.708849 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Apr 29 23:55:22.711913 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 29 23:55:22.729242 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 29 23:55:22.736092 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 29 23:55:22.768905 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:55:22.768986 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:55:22.769012 kernel: BTRFS info (device nvme0n1p6): using free space tree Apr 29 23:55:22.779016 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 29 23:55:22.797474 systemd[1]: mnt-oem.mount: Deactivated successfully. Apr 29 23:55:22.799876 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:55:22.811083 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 29 23:55:22.824366 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 29 23:55:22.948567 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 29 23:55:22.962473 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 29 23:55:23.019568 systemd-networkd[1117]: lo: Link UP Apr 29 23:55:23.019590 systemd-networkd[1117]: lo: Gained carrier Apr 29 23:55:23.023353 systemd-networkd[1117]: Enumeration completed Apr 29 23:55:23.023599 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 29 23:55:23.025519 systemd-networkd[1117]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:55:23.025526 systemd-networkd[1117]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 29 23:55:23.029395 systemd-networkd[1117]: eth0: Link UP Apr 29 23:55:23.029407 systemd-networkd[1117]: eth0: Gained carrier Apr 29 23:55:23.029434 systemd-networkd[1117]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:55:23.033146 systemd[1]: Reached target network.target - Network. Apr 29 23:55:23.051251 systemd-networkd[1117]: eth0: DHCPv4 address 172.31.31.51/20, gateway 172.31.16.1 acquired from 172.31.16.1 Apr 29 23:55:23.107660 ignition[1030]: Ignition 2.20.0 Apr 29 23:55:23.107690 ignition[1030]: Stage: fetch-offline Apr 29 23:55:23.108423 ignition[1030]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:55:23.108448 ignition[1030]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:55:23.109546 ignition[1030]: Ignition finished successfully Apr 29 23:55:23.118750 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 29 23:55:23.130145 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Apr 29 23:55:23.164167 ignition[1126]: Ignition 2.20.0 Apr 29 23:55:23.164198 ignition[1126]: Stage: fetch Apr 29 23:55:23.165898 ignition[1126]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:55:23.165930 ignition[1126]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:55:23.166895 ignition[1126]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:55:23.179080 ignition[1126]: PUT result: OK Apr 29 23:55:23.182790 ignition[1126]: parsed url from cmdline: "" Apr 29 23:55:23.182972 ignition[1126]: no config URL provided Apr 29 23:55:23.182993 ignition[1126]: reading system config file "/usr/lib/ignition/user.ign" Apr 29 23:55:23.183021 ignition[1126]: no config at "/usr/lib/ignition/user.ign" Apr 29 23:55:23.183057 ignition[1126]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:55:23.186902 ignition[1126]: PUT result: OK Apr 29 23:55:23.187950 ignition[1126]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Apr 29 23:55:23.192114 ignition[1126]: GET result: OK Apr 29 23:55:23.195438 ignition[1126]: parsing config with SHA512: 3d0dcea429fb7dae3418be50ec5d1e568d9dc4e4e4d736e26f65c70e02a6c679c92dd4c839e8076289d0747fac6d1d9db2666d31c360290d73f7c82ac115ccd5 Apr 29 23:55:23.209855 unknown[1126]: fetched base config from "system" Apr 29 23:55:23.210432 ignition[1126]: fetch: fetch complete Apr 29 23:55:23.209881 unknown[1126]: fetched base config from "system" Apr 29 23:55:23.210444 ignition[1126]: fetch: fetch passed Apr 29 23:55:23.209895 unknown[1126]: fetched user config from "aws" Apr 29 23:55:23.210548 ignition[1126]: Ignition finished successfully Apr 29 23:55:23.222889 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Apr 29 23:55:23.236112 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 29 23:55:23.260774 ignition[1132]: Ignition 2.20.0 Apr 29 23:55:23.260832 ignition[1132]: Stage: kargs Apr 29 23:55:23.262417 ignition[1132]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:55:23.262442 ignition[1132]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:55:23.262974 ignition[1132]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:55:23.265473 ignition[1132]: PUT result: OK Apr 29 23:55:23.273843 ignition[1132]: kargs: kargs passed Apr 29 23:55:23.273992 ignition[1132]: Ignition finished successfully Apr 29 23:55:23.278266 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 29 23:55:23.288184 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 29 23:55:23.320892 ignition[1138]: Ignition 2.20.0 Apr 29 23:55:23.320921 ignition[1138]: Stage: disks Apr 29 23:55:23.322513 ignition[1138]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:55:23.322539 ignition[1138]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:55:23.323081 ignition[1138]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:55:23.325780 ignition[1138]: PUT result: OK Apr 29 23:55:23.333901 ignition[1138]: disks: disks passed Apr 29 23:55:23.333999 ignition[1138]: Ignition finished successfully Apr 29 23:55:23.339854 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 29 23:55:23.342590 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 29 23:55:23.345936 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 29 23:55:23.350586 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 29 23:55:23.354749 systemd[1]: Reached target sysinit.target - System Initialization. Apr 29 23:55:23.358305 systemd[1]: Reached target basic.target - Basic System. Apr 29 23:55:23.380633 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 29 23:55:23.463632 systemd-fsck[1146]: ROOT: clean, 14/553520 files, 52654/553472 blocks Apr 29 23:55:23.471387 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 29 23:55:23.484056 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 29 23:55:23.580835 kernel: EXT4-fs (nvme0n1p9): mounted filesystem cd2ccabc-5b27-4350-bc86-21c9a8411827 r/w with ordered data mode. Quota mode: none. Apr 29 23:55:23.582273 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 29 23:55:23.586119 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 29 23:55:23.623970 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 29 23:55:23.639007 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 29 23:55:23.643257 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Apr 29 23:55:23.646683 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:55:23.646743 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 29 23:55:23.669837 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/nvme0n1p6 scanned by mount (1165) Apr 29 23:55:23.674898 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:55:23.674977 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:55:23.678429 kernel: BTRFS info (device nvme0n1p6): using free space tree Apr 29 23:55:23.678209 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 29 23:55:23.696199 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 29 23:55:23.714829 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 29 23:55:23.715186 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 29 23:55:23.790727 initrd-setup-root[1189]: cut: /sysroot/etc/passwd: No such file or directory Apr 29 23:55:23.799231 initrd-setup-root[1196]: cut: /sysroot/etc/group: No such file or directory Apr 29 23:55:23.809958 initrd-setup-root[1203]: cut: /sysroot/etc/shadow: No such file or directory Apr 29 23:55:23.820742 initrd-setup-root[1210]: cut: /sysroot/etc/gshadow: No such file or directory Apr 29 23:55:24.057900 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 29 23:55:24.067004 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 29 23:55:24.079163 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 29 23:55:24.098618 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 29 23:55:24.100599 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:55:24.134999 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 29 23:55:24.152337 ignition[1277]: INFO : Ignition 2.20.0 Apr 29 23:55:24.152337 ignition[1277]: INFO : Stage: mount Apr 29 23:55:24.155856 ignition[1277]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 29 23:55:24.155856 ignition[1277]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:55:24.160127 ignition[1277]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:55:24.163341 ignition[1277]: INFO : PUT result: OK Apr 29 23:55:24.167772 ignition[1277]: INFO : mount: mount passed Apr 29 23:55:24.169529 ignition[1277]: INFO : Ignition finished successfully Apr 29 23:55:24.173679 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 29 23:55:24.183044 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 29 23:55:24.215217 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 29 23:55:24.236843 kernel: BTRFS: device label OEM devid 1 transid 17 /dev/nvme0n1p6 scanned by mount (1290) Apr 29 23:55:24.240653 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:55:24.240694 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:55:24.240719 kernel: BTRFS info (device nvme0n1p6): using free space tree Apr 29 23:55:24.246839 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 29 23:55:24.250696 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 29 23:55:24.289066 ignition[1307]: INFO : Ignition 2.20.0 Apr 29 23:55:24.289066 ignition[1307]: INFO : Stage: files Apr 29 23:55:24.292393 ignition[1307]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 29 23:55:24.292393 ignition[1307]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:55:24.292393 ignition[1307]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:55:24.299468 ignition[1307]: INFO : PUT result: OK Apr 29 23:55:24.303436 ignition[1307]: DEBUG : files: compiled without relabeling support, skipping Apr 29 23:55:24.307082 ignition[1307]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 29 23:55:24.307082 ignition[1307]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 29 23:55:24.317188 ignition[1307]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 29 23:55:24.320012 ignition[1307]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 29 23:55:24.323106 unknown[1307]: wrote ssh authorized keys file for user: core Apr 29 23:55:24.327448 ignition[1307]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/hostname" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/hostname" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/exports" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/exports" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/var/lib/nfs/etab" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/var/lib/nfs/etab" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: op(7): [started] processing unit "nfs-server.service" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: op(7): [finished] processing unit "nfs-server.service" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: op(8): [started] setting preset to enabled for "nfs-server.service" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: op(8): [finished] setting preset to enabled for "nfs-server.service" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: createResultFile: createFiles: op(9): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: createResultFile: createFiles: op(9): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 29 23:55:24.332915 ignition[1307]: INFO : files: files passed Apr 29 23:55:24.332915 ignition[1307]: INFO : Ignition finished successfully Apr 29 23:55:24.378918 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 29 23:55:24.388190 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 29 23:55:24.400182 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 29 23:55:24.412526 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 29 23:55:24.415034 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 29 23:55:24.434616 initrd-setup-root-after-ignition[1336]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 29 23:55:24.434616 initrd-setup-root-after-ignition[1336]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 29 23:55:24.443288 initrd-setup-root-after-ignition[1340]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 29 23:55:24.452912 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 29 23:55:24.457268 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 29 23:55:24.469385 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 29 23:55:24.528772 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 29 23:55:24.529197 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 29 23:55:24.536145 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 29 23:55:24.538193 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 29 23:55:24.540518 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 29 23:55:24.553086 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 29 23:55:24.586906 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 29 23:55:24.597443 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 29 23:55:24.634950 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 29 23:55:24.639325 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 29 23:55:24.641249 systemd[1]: Stopped target timers.target - Timer Units. Apr 29 23:55:24.641557 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 29 23:55:24.641876 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 29 23:55:24.643353 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 29 23:55:24.644038 systemd[1]: Stopped target basic.target - Basic System. Apr 29 23:55:24.644651 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 29 23:55:24.645574 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 29 23:55:24.646471 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 29 23:55:24.647126 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 29 23:55:24.647695 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 29 23:55:24.648315 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 29 23:55:24.649023 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 29 23:55:24.649923 systemd[1]: Stopped target swap.target - Swaps. Apr 29 23:55:24.650334 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 29 23:55:24.650644 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 29 23:55:24.652448 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 29 23:55:24.652863 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 29 23:55:24.657689 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 29 23:55:24.668510 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 29 23:55:24.673328 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 29 23:55:24.673907 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 29 23:55:24.712449 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 29 23:55:24.712748 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 29 23:55:24.715532 systemd[1]: ignition-files.service: Deactivated successfully. Apr 29 23:55:24.715765 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 29 23:55:24.737746 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 29 23:55:24.743973 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 29 23:55:24.746892 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 29 23:55:24.761486 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 29 23:55:24.763381 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 29 23:55:24.765569 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 29 23:55:24.773118 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 29 23:55:24.778390 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 29 23:55:24.779446 systemd-networkd[1117]: eth0: Gained IPv6LL Apr 29 23:55:24.795120 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 29 23:55:24.797393 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 29 23:55:24.801860 ignition[1360]: INFO : Ignition 2.20.0 Apr 29 23:55:24.801860 ignition[1360]: INFO : Stage: umount Apr 29 23:55:24.801860 ignition[1360]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 29 23:55:24.801860 ignition[1360]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 29 23:55:24.814478 ignition[1360]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 29 23:55:24.814478 ignition[1360]: INFO : PUT result: OK Apr 29 23:55:24.819831 ignition[1360]: INFO : umount: umount passed Apr 29 23:55:24.821567 ignition[1360]: INFO : Ignition finished successfully Apr 29 23:55:24.825252 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 29 23:55:24.827276 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 29 23:55:24.832537 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 29 23:55:24.832718 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 29 23:55:24.840081 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 29 23:55:24.840203 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 29 23:55:24.844241 systemd[1]: ignition-fetch.service: Deactivated successfully. Apr 29 23:55:24.845513 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Apr 29 23:55:24.847491 systemd[1]: Stopped target network.target - Network. Apr 29 23:55:24.853476 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 29 23:55:24.853898 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 29 23:55:24.857582 systemd[1]: Stopped target paths.target - Path Units. Apr 29 23:55:24.859969 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 29 23:55:24.873202 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 29 23:55:24.875905 systemd[1]: Stopped target slices.target - Slice Units. Apr 29 23:55:24.877637 systemd[1]: Stopped target sockets.target - Socket Units. Apr 29 23:55:24.879492 systemd[1]: iscsid.socket: Deactivated successfully. Apr 29 23:55:24.879579 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 29 23:55:24.881450 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 29 23:55:24.881519 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 29 23:55:24.883422 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 29 23:55:24.883508 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 29 23:55:24.885739 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 29 23:55:24.885832 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 29 23:55:24.896380 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 29 23:55:24.899974 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 29 23:55:24.905684 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 29 23:55:24.906745 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 29 23:55:24.906942 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 29 23:55:24.915118 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 29 23:55:24.915328 systemd-networkd[1117]: eth0: DHCPv6 lease lost Apr 29 23:55:24.916100 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 29 23:55:24.927946 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 29 23:55:24.928114 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 29 23:55:24.933858 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 29 23:55:24.935883 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 29 23:55:24.949579 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 29 23:55:24.949793 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 29 23:55:24.955662 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 29 23:55:24.955735 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 29 23:55:24.974088 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 29 23:55:24.978117 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 29 23:55:24.978356 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 29 23:55:24.983070 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 29 23:55:24.983172 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 29 23:55:24.985585 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 29 23:55:24.985663 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 29 23:55:24.991764 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 29 23:55:25.032913 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 29 23:55:25.036956 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 29 23:55:25.042607 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 29 23:55:25.044490 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 29 23:55:25.049110 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 29 23:55:25.049239 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 29 23:55:25.054948 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 29 23:55:25.055026 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Apr 29 23:55:25.057003 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 29 23:55:25.057116 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 29 23:55:25.059354 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 29 23:55:25.059435 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 29 23:55:25.072592 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 29 23:55:25.072696 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:55:25.090219 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 29 23:55:25.095644 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 29 23:55:25.095771 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 29 23:55:25.098268 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 29 23:55:25.098361 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:55:25.114016 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 29 23:55:25.116199 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 29 23:55:25.122453 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 29 23:55:25.145207 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 29 23:55:25.164475 systemd[1]: Switching root. Apr 29 23:55:25.195124 systemd-journald[252]: Journal stopped Apr 29 23:55:27.085108 systemd-journald[252]: Received SIGTERM from PID 1 (systemd). Apr 29 23:55:27.087976 kernel: SELinux: policy capability network_peer_controls=1 Apr 29 23:55:27.088029 kernel: SELinux: policy capability open_perms=1 Apr 29 23:55:27.088078 kernel: SELinux: policy capability extended_socket_class=1 Apr 29 23:55:27.088111 kernel: SELinux: policy capability always_check_network=0 Apr 29 23:55:27.088143 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 29 23:55:27.088175 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 29 23:55:27.088205 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 29 23:55:27.088236 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 29 23:55:27.088267 kernel: audit: type=1403 audit(1745970925.354:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 29 23:55:27.088301 systemd[1]: Successfully loaded SELinux policy in 52.796ms. Apr 29 23:55:27.088358 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.363ms. Apr 29 23:55:27.088397 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:55:27.088432 systemd[1]: Detected virtualization amazon. Apr 29 23:55:27.088466 systemd[1]: Detected architecture arm64. Apr 29 23:55:27.088498 systemd[1]: Detected first boot. Apr 29 23:55:27.088532 systemd[1]: Hostname set to . Apr 29 23:55:27.088569 systemd[1]: Initializing machine ID from VM UUID. Apr 29 23:55:27.088605 zram_generator::config[1407]: No configuration found. Apr 29 23:55:27.088651 (sd-exec-[1387]: /usr/lib/systemd/system-generators/nfs-server-generator failed with exit status 1. Apr 29 23:55:27.088685 systemd[1]: Populated /etc with preset unit settings. Apr 29 23:55:27.088716 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 29 23:55:27.088748 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 29 23:55:27.088782 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 29 23:55:27.089885 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 29 23:55:27.089934 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 29 23:55:27.089966 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 29 23:55:27.090008 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 29 23:55:27.090045 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 29 23:55:27.090080 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 29 23:55:27.090125 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 29 23:55:27.090154 systemd[1]: Created slice user.slice - User and Session Slice. Apr 29 23:55:27.090197 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 29 23:55:27.090231 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 29 23:55:27.090262 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 29 23:55:27.090296 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 29 23:55:27.090327 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 29 23:55:27.090359 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 29 23:55:27.090390 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Apr 29 23:55:27.090419 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 29 23:55:27.090453 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 29 23:55:27.090482 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 29 23:55:27.090514 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 29 23:55:27.090545 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 29 23:55:27.090577 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 29 23:55:27.090618 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 29 23:55:27.090647 systemd[1]: Reached target slices.target - Slice Units. Apr 29 23:55:27.090677 systemd[1]: Reached target swap.target - Swaps. Apr 29 23:55:27.090710 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 29 23:55:27.090739 systemd[1]: Listening on rpcbind.socket - RPCbind Server Activation Socket. Apr 29 23:55:27.090772 systemd[1]: Reached target rpcbind.target - RPC Port Mapper. Apr 29 23:55:27.091876 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 29 23:55:27.091948 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 29 23:55:27.091980 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 29 23:55:27.092019 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 29 23:55:27.092053 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 29 23:55:27.092085 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 29 23:55:27.092123 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 29 23:55:27.092152 systemd[1]: Mounting media.mount - External Media Directory... Apr 29 23:55:27.092186 systemd[1]: Mounting proc-fs-nfsd.mount - NFSD configuration filesystem... Apr 29 23:55:27.092217 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 29 23:55:27.092248 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 29 23:55:27.092285 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 29 23:55:27.092315 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:55:27.092357 systemd[1]: Reached target machines.target - Containers. Apr 29 23:55:27.092388 systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Apr 29 23:55:27.092421 kernel: RPC: Registered named UNIX socket transport module. Apr 29 23:55:27.092461 kernel: RPC: Registered udp transport module. Apr 29 23:55:27.092488 kernel: RPC: Registered tcp transport module. Apr 29 23:55:27.092520 kernel: RPC: Registered tcp-with-tls transport module. Apr 29 23:55:27.092550 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Apr 29 23:55:27.092583 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 29 23:55:27.092613 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:55:27.092641 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 29 23:55:27.092674 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 29 23:55:27.092707 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 29 23:55:27.092740 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 29 23:55:27.092768 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 29 23:55:27.092797 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 29 23:55:27.092896 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 29 23:55:27.092926 systemd[1]: Starting rpcbind.service - RPC Bind... Apr 29 23:55:27.092956 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 29 23:55:27.092985 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 29 23:55:27.093022 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 29 23:55:27.093072 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 29 23:55:27.093106 systemd[1]: Stopped systemd-fsck-usr.service. Apr 29 23:55:27.093136 kernel: loop: module loaded Apr 29 23:55:27.093166 (rpcbind)[1489]: rpcbind.service: Referenced but unset environment variable evaluates to an empty string: RPCBIND_OPTIONS Apr 29 23:55:27.093200 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 29 23:55:27.093229 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 29 23:55:27.093258 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 29 23:55:27.093292 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 29 23:55:27.093323 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 29 23:55:27.093354 systemd[1]: verity-setup.service: Deactivated successfully. Apr 29 23:55:27.093382 systemd[1]: Stopped verity-setup.service. Apr 29 23:55:27.093411 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 29 23:55:27.093444 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 29 23:55:27.093473 systemd[1]: Mounted media.mount - External Media Directory. Apr 29 23:55:27.093502 systemd[1]: Mounted proc-fs-nfsd.mount - NFSD configuration filesystem. Apr 29 23:55:27.093531 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 29 23:55:27.093558 kernel: ACPI: bus type drm_connector registered Apr 29 23:55:27.093586 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 29 23:55:27.093617 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 29 23:55:27.093646 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 29 23:55:27.093674 systemd[1]: Started rpcbind.service - RPC Bind. Apr 29 23:55:27.093707 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 29 23:55:27.093738 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 29 23:55:27.093769 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 29 23:55:27.096476 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 29 23:55:27.096630 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 29 23:55:27.096668 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 29 23:55:27.096698 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 29 23:55:27.096728 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 29 23:55:27.098813 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 29 23:55:27.098879 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 29 23:55:27.098913 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 29 23:55:27.098944 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 29 23:55:27.098975 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 29 23:55:27.099142 systemd-journald[1494]: Collecting audit messages is disabled. Apr 29 23:55:27.099218 kernel: fuse: init (API version 7.39) Apr 29 23:55:27.099253 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 29 23:55:27.099283 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 29 23:55:27.099315 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 29 23:55:27.099360 systemd-journald[1494]: Journal started Apr 29 23:55:27.099447 systemd-journald[1494]: Runtime Journal (/run/log/journal/ec224dbaa0a0b0113a56eb94829ade08) is 8.0M, max 75.3M, 67.3M free. Apr 29 23:55:26.356714 systemd[1]: Queued start job for default target multi-user.target. Apr 29 23:55:26.384075 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Apr 29 23:55:26.384884 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 29 23:55:27.105002 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Apr 29 23:55:27.126569 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 29 23:55:27.143478 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 29 23:55:27.143584 systemd[1]: rpc-svcgssd.service - RPC security service for NFS server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Apr 29 23:55:27.143623 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:55:27.166840 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 29 23:55:27.166936 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 29 23:55:27.178920 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 29 23:55:27.179016 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 29 23:55:27.198322 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 29 23:55:27.210386 systemd[1]: Started systemd-journald.service - Journal Service. Apr 29 23:55:27.219300 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 29 23:55:27.219897 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 29 23:55:27.222666 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 29 23:55:27.226260 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 29 23:55:27.229289 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 29 23:55:27.278183 kernel: loop0: detected capacity change from 0 to 113536 Apr 29 23:55:27.277026 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 29 23:55:27.308279 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 29 23:55:27.329093 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 29 23:55:27.345353 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 29 23:55:27.382006 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 29 23:55:27.369696 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 29 23:55:27.379291 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 29 23:55:27.383364 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 29 23:55:27.389389 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 29 23:55:27.406887 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Apr 29 23:55:27.440251 systemd-journald[1494]: Time spent on flushing to /var/log/journal/ec224dbaa0a0b0113a56eb94829ade08 is 151.097ms for 911 entries. Apr 29 23:55:27.440251 systemd-journald[1494]: System Journal (/var/log/journal/ec224dbaa0a0b0113a56eb94829ade08) is 8.0M, max 195.6M, 187.6M free. Apr 29 23:55:27.620212 systemd-journald[1494]: Received client request to flush runtime journal. Apr 29 23:55:27.620337 kernel: loop1: detected capacity change from 0 to 116808 Apr 29 23:55:27.620400 kernel: loop2: detected capacity change from 0 to 53784 Apr 29 23:55:27.499147 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 29 23:55:27.514190 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Apr 29 23:55:27.546632 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 29 23:55:27.585649 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 29 23:55:27.602097 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 29 23:55:27.636476 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 29 23:55:27.638241 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 29 23:55:27.641707 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Apr 29 23:55:27.651168 udevadm[1555]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Apr 29 23:55:27.684035 systemd-tmpfiles[1562]: ACLs are not supported, ignoring. Apr 29 23:55:27.684074 systemd-tmpfiles[1562]: ACLs are not supported, ignoring. Apr 29 23:55:27.692312 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 29 23:55:27.807667 kernel: loop3: detected capacity change from 0 to 113536 Apr 29 23:55:27.840859 kernel: loop4: detected capacity change from 0 to 116808 Apr 29 23:55:27.883697 kernel: loop5: detected capacity change from 0 to 53784 Apr 29 23:55:27.896463 (sd-merge)[1569]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Apr 29 23:55:27.897406 (sd-merge)[1569]: Merged extensions into '/usr'. Apr 29 23:55:27.910200 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 29 23:55:27.920124 systemd[1]: Starting ensure-sysext.service... Apr 29 23:55:27.930206 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 29 23:55:27.972147 systemd[1]: Reloading requested from client PID 1571 ('systemctl') (unit ensure-sysext.service)... Apr 29 23:55:27.972183 systemd[1]: Reloading... Apr 29 23:55:28.032715 systemd-tmpfiles[1572]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 29 23:55:28.037649 systemd-tmpfiles[1572]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Apr 29 23:55:28.041924 systemd-tmpfiles[1572]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 29 23:55:28.042448 systemd-tmpfiles[1572]: ACLs are not supported, ignoring. Apr 29 23:55:28.042590 systemd-tmpfiles[1572]: ACLs are not supported, ignoring. Apr 29 23:55:28.065461 systemd-tmpfiles[1572]: Detected autofs mount point /boot during canonicalization of boot. Apr 29 23:55:28.067652 systemd-tmpfiles[1572]: Skipping /boot Apr 29 23:55:28.146074 systemd-tmpfiles[1572]: Detected autofs mount point /boot during canonicalization of boot. Apr 29 23:55:28.149196 systemd-tmpfiles[1572]: Skipping /boot Apr 29 23:55:28.175672 ldconfig[1511]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 29 23:55:28.197899 zram_generator::config[1601]: No configuration found. Apr 29 23:55:28.359714 (sd-exec-[1581]: /usr/lib/systemd/system-generators/nfs-server-generator failed with exit status 1. Apr 29 23:55:28.506718 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:55:28.626838 systemd[1]: Reloading finished in 653 ms. Apr 29 23:55:28.670940 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 29 23:55:28.675188 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 29 23:55:28.718120 systemd[1]: Mounting var-lib-nfs-rpc_pipefs.mount - RPC Pipe File System... Apr 29 23:55:28.730153 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 29 23:55:28.747378 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 29 23:55:28.755410 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 29 23:55:28.771687 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 29 23:55:28.784268 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 29 23:55:28.792218 systemd[1]: Mounted var-lib-nfs-rpc_pipefs.mount - RPC Pipe File System. Apr 29 23:55:28.799826 systemd[1]: Reached target rpc_pipefs.target. Apr 29 23:55:28.813361 systemd[1]: Starting nfs-idmapd.service - NFSv4 ID-name mapping service... Apr 29 23:55:28.820291 systemd[1]: Starting nfsdcld.service - NFSv4 Client Tracking Daemon... Apr 29 23:55:28.822355 systemd[1]: rpc-gssd.service - RPC security service for NFS client and server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Apr 29 23:55:28.827528 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:55:28.835566 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 29 23:55:28.842294 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 29 23:55:28.851181 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 29 23:55:28.853355 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:55:28.860345 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:55:28.860869 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:55:28.874622 systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Apr 29 23:55:28.876340 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:55:28.885697 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 29 23:55:28.888690 systemd[1]: rpc-gssd.service - RPC security service for NFS client and server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Apr 29 23:55:28.890121 systemd[1]: rpc-svcgssd.service - RPC security service for NFS server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Apr 29 23:55:28.890474 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:55:28.890918 systemd[1]: Reached target time-set.target - System Time Set. Apr 29 23:55:28.907900 systemd[1]: Finished ensure-sysext.service. Apr 29 23:55:28.911533 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 29 23:55:28.917241 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 29 23:55:28.949948 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 29 23:55:28.973193 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 29 23:55:28.979208 rpc.idmapd[1684]: Setting log level to 0 Apr 29 23:55:28.990497 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 29 23:55:28.993721 systemd[1]: Started nfsdcld.service - NFSv4 Client Tracking Daemon. Apr 29 23:55:29.012925 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 29 23:55:29.032531 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 29 23:55:29.033687 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 29 23:55:29.037767 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 29 23:55:29.038948 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 29 23:55:29.041790 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 29 23:55:29.053554 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 29 23:55:29.056543 systemd[1]: Started nfs-idmapd.service - NFSv4 ID-name mapping service. Apr 29 23:55:29.066530 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 29 23:55:29.072420 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 29 23:55:29.072879 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 29 23:55:29.076630 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 29 23:55:29.109967 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 29 23:55:29.131227 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 29 23:55:29.134598 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:55:29.137013 augenrules[1703]: No rules Apr 29 23:55:29.146311 systemd[1]: audit-rules.service: Deactivated successfully. Apr 29 23:55:29.147142 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 29 23:55:29.162990 systemd-udevd[1680]: Using default interface naming scheme 'v255'. Apr 29 23:55:29.179653 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 29 23:55:29.215146 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 29 23:55:29.226232 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 29 23:55:29.384211 systemd-resolved[1659]: Positive Trust Anchors: Apr 29 23:55:29.384788 systemd-resolved[1659]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 29 23:55:29.384995 systemd-resolved[1659]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Apr 29 23:55:29.395379 systemd-resolved[1659]: Using system hostname 'nfs1'. Apr 29 23:55:29.406503 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 29 23:55:29.408865 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 29 23:55:29.457633 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Apr 29 23:55:29.464446 systemd-networkd[1716]: lo: Link UP Apr 29 23:55:29.464996 systemd-networkd[1716]: lo: Gained carrier Apr 29 23:55:29.473840 systemd-networkd[1716]: Enumeration completed Apr 29 23:55:29.474032 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 29 23:55:29.478295 systemd[1]: Reached target network.target - Network. Apr 29 23:55:29.498021 (udev-worker)[1722]: Network interface NamePolicy= disabled on kernel command line. Apr 29 23:55:29.502414 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 29 23:55:29.598784 systemd-networkd[1716]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:55:29.599028 systemd-networkd[1716]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 29 23:55:29.603241 systemd-networkd[1716]: eth0: Link UP Apr 29 23:55:29.603530 systemd-networkd[1716]: eth0: Gained carrier Apr 29 23:55:29.603563 systemd-networkd[1716]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:55:29.619952 systemd-networkd[1716]: eth0: DHCPv4 address 172.31.31.51/20, gateway 172.31.16.1 acquired from 172.31.16.1 Apr 29 23:55:29.643880 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 43 scanned by (udev-worker) (1736) Apr 29 23:55:29.749543 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:55:29.922942 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Apr 29 23:55:29.935981 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:55:29.939257 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Apr 29 23:55:29.958165 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Apr 29 23:55:29.963297 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 29 23:55:29.983831 lvm[1838]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 29 23:55:30.005032 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 29 23:55:30.023998 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Apr 29 23:55:30.027606 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 29 23:55:30.030008 systemd[1]: Reached target sysinit.target - System Initialization. Apr 29 23:55:30.032400 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 29 23:55:30.034833 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:55:30.037537 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 29 23:55:30.039879 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 29 23:55:30.042308 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 29 23:55:30.044673 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 29 23:55:30.044719 systemd[1]: Reached target paths.target - Path Units. Apr 29 23:55:30.046791 systemd[1]: Reached target timers.target - Timer Units. Apr 29 23:55:30.050217 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 29 23:55:30.056137 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 29 23:55:30.079644 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 29 23:55:30.085005 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Apr 29 23:55:30.088910 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 29 23:55:30.092334 systemd[1]: Reached target sockets.target - Socket Units. Apr 29 23:55:30.094667 systemd[1]: Reached target basic.target - Basic System. Apr 29 23:55:30.097137 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 29 23:55:30.097194 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 29 23:55:30.105147 systemd[1]: Starting containerd.service - containerd container runtime... Apr 29 23:55:30.112153 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Apr 29 23:55:30.120103 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 29 23:55:30.130208 lvm[1845]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 29 23:55:30.125151 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 29 23:55:30.136165 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 29 23:55:30.138222 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:55:30.153664 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 29 23:55:30.161782 systemd[1]: Started ntpd.service - Network Time Service. Apr 29 23:55:30.170235 systemd[1]: Starting setup-oem.service - Setup OEM... Apr 29 23:55:30.177354 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 29 23:55:30.185979 jq[1849]: false Apr 29 23:55:30.192252 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 29 23:55:30.210317 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 29 23:55:30.213292 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 29 23:55:30.215080 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 29 23:55:30.218554 systemd[1]: Starting update-engine.service - Update Engine... Apr 29 23:55:30.227165 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 29 23:55:30.239091 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 29 23:55:30.239480 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 29 23:55:30.273345 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Apr 29 23:55:30.307840 jq[1859]: true Apr 29 23:55:30.329916 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: ntpd 4.2.8p17@1.4004-o Tue Apr 29 21:35:04 UTC 2025 (1): Starting Apr 29 23:55:30.329916 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Apr 29 23:55:30.329916 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: ---------------------------------------------------- Apr 29 23:55:30.329916 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: ntp-4 is maintained by Network Time Foundation, Apr 29 23:55:30.329916 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Apr 29 23:55:30.329916 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: corporation. Support and training for ntp-4 are Apr 29 23:55:30.329916 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: available at https://www.nwtime.org/support Apr 29 23:55:30.329916 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: ---------------------------------------------------- Apr 29 23:55:30.329916 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: proto: precision = 0.096 usec (-23) Apr 29 23:55:30.319546 ntpd[1852]: ntpd 4.2.8p17@1.4004-o Tue Apr 29 21:35:04 UTC 2025 (1): Starting Apr 29 23:55:30.319618 ntpd[1852]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Apr 29 23:55:30.364997 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: basedate set to 2025-04-17 Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: gps base set to 2025-04-20 (week 2363) Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: Listen and drop on 0 v6wildcard [::]:123 Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: Listen normally on 2 lo 127.0.0.1:123 Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: Listen normally on 3 eth0 172.31.31.51:123 Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: Listen normally on 4 lo [::1]:123 Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: bind(21) AF_INET6 fe80::462:ffff:fe38:a8b9%2#123 flags 0x11 failed: Cannot assign requested address Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: unable to create socket on eth0 (5) for fe80::462:ffff:fe38:a8b9%2#123 Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: failed to init interface for address fe80::462:ffff:fe38:a8b9%2 Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: Listening on routing socket on fd #21 for interface updates Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 29 23:55:30.365745 ntpd[1852]: 29 Apr 23:55:30 ntpd[1852]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 29 23:55:30.319638 ntpd[1852]: ---------------------------------------------------- Apr 29 23:55:30.319659 ntpd[1852]: ntp-4 is maintained by Network Time Foundation, Apr 29 23:55:30.319677 ntpd[1852]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Apr 29 23:55:30.319695 ntpd[1852]: corporation. Support and training for ntp-4 are Apr 29 23:55:30.319715 ntpd[1852]: available at https://www.nwtime.org/support Apr 29 23:55:30.366953 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 29 23:55:30.319733 ntpd[1852]: ---------------------------------------------------- Apr 29 23:55:30.324312 ntpd[1852]: proto: precision = 0.096 usec (-23) Apr 29 23:55:30.334176 ntpd[1852]: basedate set to 2025-04-17 Apr 29 23:55:30.334218 ntpd[1852]: gps base set to 2025-04-20 (week 2363) Apr 29 23:55:30.341093 ntpd[1852]: Listen and drop on 0 v6wildcard [::]:123 Apr 29 23:55:30.341174 ntpd[1852]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 29 23:55:30.343041 ntpd[1852]: Listen normally on 2 lo 127.0.0.1:123 Apr 29 23:55:30.343113 ntpd[1852]: Listen normally on 3 eth0 172.31.31.51:123 Apr 29 23:55:30.343181 ntpd[1852]: Listen normally on 4 lo [::1]:123 Apr 29 23:55:30.343262 ntpd[1852]: bind(21) AF_INET6 fe80::462:ffff:fe38:a8b9%2#123 flags 0x11 failed: Cannot assign requested address Apr 29 23:55:30.343299 ntpd[1852]: unable to create socket on eth0 (5) for fe80::462:ffff:fe38:a8b9%2#123 Apr 29 23:55:30.343330 ntpd[1852]: failed to init interface for address fe80::462:ffff:fe38:a8b9%2 Apr 29 23:55:30.343384 ntpd[1852]: Listening on routing socket on fd #21 for interface updates Apr 29 23:55:30.351460 ntpd[1852]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 29 23:55:30.351520 ntpd[1852]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 29 23:55:30.410506 jq[1873]: true Apr 29 23:55:30.425738 extend-filesystems[1850]: Found loop3 Apr 29 23:55:30.425738 extend-filesystems[1850]: Found loop4 Apr 29 23:55:30.425738 extend-filesystems[1850]: Found loop5 Apr 29 23:55:30.425738 extend-filesystems[1850]: Found nvme0n1 Apr 29 23:55:30.425738 extend-filesystems[1850]: Found nvme0n1p1 Apr 29 23:55:30.425738 extend-filesystems[1850]: Found nvme0n1p2 Apr 29 23:55:30.425738 extend-filesystems[1850]: Found nvme0n1p3 Apr 29 23:55:30.425738 extend-filesystems[1850]: Found usr Apr 29 23:55:30.425738 extend-filesystems[1850]: Found nvme0n1p4 Apr 29 23:55:30.425738 extend-filesystems[1850]: Found nvme0n1p6 Apr 29 23:55:30.425738 extend-filesystems[1850]: Found nvme0n1p7 Apr 29 23:55:30.425738 extend-filesystems[1850]: Found nvme0n1p9 Apr 29 23:55:30.425738 extend-filesystems[1850]: Checking size of /dev/nvme0n1p9 Apr 29 23:55:30.528328 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Apr 29 23:55:30.425172 dbus-daemon[1848]: [system] SELinux support is enabled Apr 29 23:55:30.529199 update_engine[1858]: I20250429 23:55:30.455046 1858 main.cc:92] Flatcar Update Engine starting Apr 29 23:55:30.529199 update_engine[1858]: I20250429 23:55:30.465193 1858 update_check_scheduler.cc:74] Next update check in 7m54s Apr 29 23:55:30.529638 extend-filesystems[1850]: Resized partition /dev/nvme0n1p9 Apr 29 23:55:30.509704 (ntainerd)[1881]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 29 23:55:30.431625 dbus-daemon[1848]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1716 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Apr 29 23:55:30.536302 extend-filesystems[1891]: resize2fs 1.47.1 (20-May-2024) Apr 29 23:55:30.548398 systemd-logind[1856]: Watching system buttons on /dev/input/event0 (Power Button) Apr 29 23:55:30.548450 systemd-logind[1856]: Watching system buttons on /dev/input/event1 (Sleep Button) Apr 29 23:55:30.553108 systemd-logind[1856]: New seat seat0. Apr 29 23:55:30.566921 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 29 23:55:30.573629 systemd[1]: Started systemd-logind.service - User Login Management. Apr 29 23:55:30.577304 systemd[1]: motdgen.service: Deactivated successfully. Apr 29 23:55:30.578415 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 29 23:55:30.613622 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:55:30.613905 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 29 23:55:30.618561 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:55:30.618648 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 29 23:55:30.622604 systemd[1]: Started update-engine.service - Update Engine. Apr 29 23:55:30.629101 dbus-daemon[1848]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 29 23:55:30.644003 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 29 23:55:30.653574 systemd[1]: Finished setup-oem.service - Setup OEM. Apr 29 23:55:30.673947 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Apr 29 23:55:30.692747 extend-filesystems[1891]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Apr 29 23:55:30.692747 extend-filesystems[1891]: old_desc_blocks = 1, new_desc_blocks = 1 Apr 29 23:55:30.692747 extend-filesystems[1891]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Apr 29 23:55:30.698275 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Apr 29 23:55:30.706132 extend-filesystems[1850]: Resized filesystem in /dev/nvme0n1p9 Apr 29 23:55:30.706048 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 29 23:55:30.708900 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 29 23:55:30.720852 bash[1919]: Updated "/home/core/.ssh/authorized_keys" Apr 29 23:55:30.727110 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 29 23:55:30.758396 systemd[1]: Starting sshkeys.service... Apr 29 23:55:30.802904 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 43 scanned by (udev-worker) (1729) Apr 29 23:55:30.847909 coreos-metadata[1847]: Apr 29 23:55:30.847 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Apr 29 23:55:30.861838 coreos-metadata[1847]: Apr 29 23:55:30.857 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Apr 29 23:55:30.861838 coreos-metadata[1847]: Apr 29 23:55:30.859 INFO Fetch successful Apr 29 23:55:30.861838 coreos-metadata[1847]: Apr 29 23:55:30.859 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Apr 29 23:55:30.865382 coreos-metadata[1847]: Apr 29 23:55:30.864 INFO Fetch successful Apr 29 23:55:30.865382 coreos-metadata[1847]: Apr 29 23:55:30.864 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Apr 29 23:55:30.872268 coreos-metadata[1847]: Apr 29 23:55:30.871 INFO Fetch successful Apr 29 23:55:30.872268 coreos-metadata[1847]: Apr 29 23:55:30.871 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Apr 29 23:55:30.882637 coreos-metadata[1847]: Apr 29 23:55:30.878 INFO Fetch successful Apr 29 23:55:30.882637 coreos-metadata[1847]: Apr 29 23:55:30.878 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Apr 29 23:55:30.883185 coreos-metadata[1847]: Apr 29 23:55:30.882 INFO Fetch failed with 404: resource not found Apr 29 23:55:30.883185 coreos-metadata[1847]: Apr 29 23:55:30.882 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Apr 29 23:55:30.885869 coreos-metadata[1847]: Apr 29 23:55:30.885 INFO Fetch successful Apr 29 23:55:30.885869 coreos-metadata[1847]: Apr 29 23:55:30.885 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Apr 29 23:55:30.886844 coreos-metadata[1847]: Apr 29 23:55:30.886 INFO Fetch successful Apr 29 23:55:30.886844 coreos-metadata[1847]: Apr 29 23:55:30.886 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Apr 29 23:55:30.893290 coreos-metadata[1847]: Apr 29 23:55:30.893 INFO Fetch successful Apr 29 23:55:30.893290 coreos-metadata[1847]: Apr 29 23:55:30.893 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Apr 29 23:55:30.895079 coreos-metadata[1847]: Apr 29 23:55:30.894 INFO Fetch successful Apr 29 23:55:30.895079 coreos-metadata[1847]: Apr 29 23:55:30.894 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Apr 29 23:55:30.906831 coreos-metadata[1847]: Apr 29 23:55:30.898 INFO Fetch successful Apr 29 23:55:30.918095 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Apr 29 23:55:30.973796 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Apr 29 23:55:31.053053 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Apr 29 23:55:31.058364 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 29 23:55:31.093000 locksmithd[1906]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 29 23:55:31.116327 systemd-networkd[1716]: eth0: Gained IPv6LL Apr 29 23:55:31.133584 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 29 23:55:31.137189 systemd[1]: Reached target network-online.target - Network is Online. Apr 29 23:55:31.149487 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Apr 29 23:55:31.161676 systemd[1]: Starting nfs-mountd.service - NFS Mount Daemon... Apr 29 23:55:31.202254 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 29 23:55:31.233368 systemd[1]: Starting rpc-statd.service - NFS status monitor for NFSv2/3 locking.... Apr 29 23:55:31.265896 containerd[1881]: time="2025-04-29T23:55:31.265458103Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Apr 29 23:55:31.317999 rpc.statd[2021]: Version 2.5.4 starting Apr 29 23:55:31.318020 rpc.statd[2021]: Flags: TI-RPC Apr 29 23:55:31.318943 rpc.statd[2021]: Failed to read /var/lib/nfs/state: Success Apr 29 23:55:31.318953 rpc.statd[2021]: Initializing NSM state Apr 29 23:55:31.344477 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 29 23:55:31.354879 coreos-metadata[1958]: Apr 29 23:55:31.353 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Apr 29 23:55:31.354879 coreos-metadata[1958]: Apr 29 23:55:31.353 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Apr 29 23:55:31.354879 coreos-metadata[1958]: Apr 29 23:55:31.353 INFO Fetch successful Apr 29 23:55:31.354879 coreos-metadata[1958]: Apr 29 23:55:31.353 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Apr 29 23:55:31.354879 coreos-metadata[1958]: Apr 29 23:55:31.353 INFO Fetch successful Apr 29 23:55:31.357442 unknown[1958]: wrote ssh authorized keys file for user: core Apr 29 23:55:31.385310 systemd[1]: Started rpc-statd.service - NFS status monitor for NFSv2/3 locking.. Apr 29 23:55:31.406113 rpc.mountd[2039]: Version 2.5.4 starting Apr 29 23:55:31.409916 update-ssh-keys[2031]: Updated "/home/core/.ssh/authorized_keys" Apr 29 23:55:31.414569 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Apr 29 23:55:31.426984 systemd[1]: Finished sshkeys.service. Apr 29 23:55:31.430043 systemd[1]: Started nfs-mountd.service - NFS Mount Daemon. Apr 29 23:55:31.452435 systemd[1]: Starting nfs-server.service - NFS server and services... Apr 29 23:55:31.578208 amazon-ssm-agent[2000]: Initializing new seelog logger Apr 29 23:55:31.578686 amazon-ssm-agent[2000]: New Seelog Logger Creation Complete Apr 29 23:55:31.578686 amazon-ssm-agent[2000]: 2025/04/29 23:55:31 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:55:31.578686 amazon-ssm-agent[2000]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:55:31.584550 amazon-ssm-agent[2000]: 2025/04/29 23:55:31 processing appconfig overrides Apr 29 23:55:31.584550 amazon-ssm-agent[2000]: 2025/04/29 23:55:31 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:55:31.584550 amazon-ssm-agent[2000]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:55:31.584550 amazon-ssm-agent[2000]: 2025/04/29 23:55:31 processing appconfig overrides Apr 29 23:55:31.584550 amazon-ssm-agent[2000]: 2025/04/29 23:55:31 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:55:31.584550 amazon-ssm-agent[2000]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:55:31.587983 amazon-ssm-agent[2000]: 2025/04/29 23:55:31 processing appconfig overrides Apr 29 23:55:31.588042 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO Proxy environment variables: Apr 29 23:55:31.602928 containerd[1881]: time="2025-04-29T23:55:31.602837397Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:55:31.607889 amazon-ssm-agent[2000]: 2025/04/29 23:55:31 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:55:31.607889 amazon-ssm-agent[2000]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 29 23:55:31.607889 amazon-ssm-agent[2000]: 2025/04/29 23:55:31 processing appconfig overrides Apr 29 23:55:31.612259 containerd[1881]: time="2025-04-29T23:55:31.612171009Z" 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:55:31.612259 containerd[1881]: time="2025-04-29T23:55:31.612246549Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 29 23:55:31.612404 containerd[1881]: time="2025-04-29T23:55:31.612288033Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 29 23:55:31.613872 containerd[1881]: time="2025-04-29T23:55:31.612603645Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Apr 29 23:55:31.613872 containerd[1881]: time="2025-04-29T23:55:31.612654537Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Apr 29 23:55:31.613872 containerd[1881]: time="2025-04-29T23:55:31.612823689Z" 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:55:31.613872 containerd[1881]: time="2025-04-29T23:55:31.612864333Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:55:31.613872 containerd[1881]: time="2025-04-29T23:55:31.613194525Z" 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:55:31.613872 containerd[1881]: time="2025-04-29T23:55:31.613233381Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 29 23:55:31.613872 containerd[1881]: time="2025-04-29T23:55:31.613268265Z" 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:55:31.613872 containerd[1881]: time="2025-04-29T23:55:31.613297641Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 29 23:55:31.613872 containerd[1881]: time="2025-04-29T23:55:31.613583529Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:55:31.619931 containerd[1881]: time="2025-04-29T23:55:31.619429677Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:55:31.619931 containerd[1881]: time="2025-04-29T23:55:31.619684497Z" 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:55:31.619931 containerd[1881]: time="2025-04-29T23:55:31.619716825Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 29 23:55:31.621000 containerd[1881]: time="2025-04-29T23:55:31.620493237Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 29 23:55:31.621000 containerd[1881]: time="2025-04-29T23:55:31.620656989Z" level=info msg="metadata content store policy set" policy=shared Apr 29 23:55:31.626877 containerd[1881]: time="2025-04-29T23:55:31.626597493Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 29 23:55:31.630286 containerd[1881]: time="2025-04-29T23:55:31.626796861Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 29 23:55:31.630286 containerd[1881]: time="2025-04-29T23:55:31.627549981Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Apr 29 23:55:31.630286 containerd[1881]: time="2025-04-29T23:55:31.627588765Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Apr 29 23:55:31.630286 containerd[1881]: time="2025-04-29T23:55:31.627631653Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 29 23:55:31.630286 containerd[1881]: time="2025-04-29T23:55:31.627956889Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 29 23:55:31.630286 containerd[1881]: time="2025-04-29T23:55:31.628412949Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 29 23:55:31.630286 containerd[1881]: time="2025-04-29T23:55:31.628652013Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Apr 29 23:55:31.630286 containerd[1881]: time="2025-04-29T23:55:31.628708329Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Apr 29 23:55:31.630286 containerd[1881]: time="2025-04-29T23:55:31.628749537Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Apr 29 23:55:31.631399 dbus-daemon[1848]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.628792221Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632187693Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632228325Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632260017Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632296065Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632327661Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632358189Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632389857Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632443041Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632474889Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632505477Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632535885Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632566041Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.636457 containerd[1881]: time="2025-04-29T23:55:31.632596641Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.634935 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632624097Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632653521Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632682573Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632722869Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632753361Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632781153Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632831097Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632872677Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632931237Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632964405Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.632991261Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.633197229Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 29 23:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.633259605Z" 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:55:31.638437 containerd[1881]: time="2025-04-29T23:55:31.633290529Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 29 23:55:31.639010 containerd[1881]: time="2025-04-29T23:55:31.633323637Z" 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:55:31.639010 containerd[1881]: time="2025-04-29T23:55:31.633352941Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.639010 containerd[1881]: time="2025-04-29T23:55:31.633389577Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Apr 29 23:55:31.639010 containerd[1881]: time="2025-04-29T23:55:31.633417033Z" level=info msg="NRI interface is disabled by configuration." Apr 29 23:55:31.639010 containerd[1881]: time="2025-04-29T23:55:31.633446097Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 29 23:55:31.644619 containerd[1881]: time="2025-04-29T23:55:31.640724925Z" 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:55:31.644619 containerd[1881]: time="2025-04-29T23:55:31.640874289Z" level=info msg="Connect containerd service" Apr 29 23:55:31.644619 containerd[1881]: time="2025-04-29T23:55:31.640955709Z" level=info msg="using legacy CRI server" Apr 29 23:55:31.644619 containerd[1881]: time="2025-04-29T23:55:31.640975281Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 29 23:55:31.644619 containerd[1881]: time="2025-04-29T23:55:31.641281341Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 29 23:55:31.654889 containerd[1881]: time="2025-04-29T23:55:31.647251209Z" 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:55:31.654889 containerd[1881]: time="2025-04-29T23:55:31.647479653Z" level=info msg="Start subscribing containerd event" Apr 29 23:55:31.654889 containerd[1881]: time="2025-04-29T23:55:31.647565465Z" level=info msg="Start recovering state" Apr 29 23:55:31.654889 containerd[1881]: time="2025-04-29T23:55:31.647688657Z" level=info msg="Start event monitor" Apr 29 23:55:31.654889 containerd[1881]: time="2025-04-29T23:55:31.647712645Z" level=info msg="Start snapshots syncer" Apr 29 23:55:31.654889 containerd[1881]: time="2025-04-29T23:55:31.647734341Z" level=info msg="Start cni network conf syncer for default" Apr 29 23:55:31.654889 containerd[1881]: time="2025-04-29T23:55:31.647753049Z" level=info msg="Start streaming server" Apr 29 23:55:31.648499 dbus-daemon[1848]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=1921 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Apr 29 23:55:31.657862 containerd[1881]: time="2025-04-29T23:55:31.655823745Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 29 23:55:31.657862 containerd[1881]: time="2025-04-29T23:55:31.655955469Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 29 23:55:31.658309 systemd[1]: Starting polkit.service - Authorization Manager... Apr 29 23:55:31.664247 containerd[1881]: time="2025-04-29T23:55:31.664127313Z" level=info msg="containerd successfully booted in 0.426865s" Apr 29 23:55:31.664335 systemd[1]: Started containerd.service - containerd container runtime. Apr 29 23:55:31.688381 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO https_proxy: Apr 29 23:55:31.694320 polkitd[2064]: Started polkitd version 121 Apr 29 23:55:31.709027 kernel: NFSD: Using nfsdcld client tracking operations. Apr 29 23:55:31.709119 kernel: NFSD: no clients to reclaim, skipping NFSv4 grace period (net f0000000) Apr 29 23:55:31.711571 polkitd[2064]: Loading rules from directory /etc/polkit-1/rules.d Apr 29 23:55:31.711709 polkitd[2064]: Loading rules from directory /usr/share/polkit-1/rules.d Apr 29 23:55:31.715309 polkitd[2064]: Finished loading, compiling and executing 2 rules Apr 29 23:55:31.718034 dbus-daemon[1848]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 29 23:55:31.718343 systemd[1]: Started polkit.service - Authorization Manager. Apr 29 23:55:31.721953 polkitd[2064]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Apr 29 23:55:31.726923 systemd[1]: Finished nfs-server.service - NFS server and services. Apr 29 23:55:31.739463 systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... Apr 29 23:55:31.769065 sm-notify[2081]: Version 2.5.4 starting Apr 29 23:55:31.773911 systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. Apr 29 23:55:31.786445 systemd-hostnamed[1921]: Hostname set to (static) Apr 29 23:55:31.788176 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO http_proxy: Apr 29 23:55:31.889824 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO no_proxy: Apr 29 23:55:31.986961 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO Checking if agent identity type OnPrem can be assumed Apr 29 23:55:32.088880 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO Checking if agent identity type EC2 can be assumed Apr 29 23:55:32.187989 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO Agent will take identity from EC2 Apr 29 23:55:32.217411 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 29 23:55:32.217835 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 29 23:55:32.218025 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 29 23:55:32.218185 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Apr 29 23:55:32.218309 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Apr 29 23:55:32.218426 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO [amazon-ssm-agent] Starting Core Agent Apr 29 23:55:32.218542 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO [amazon-ssm-agent] registrar detected. Attempting registration Apr 29 23:55:32.218662 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO [Registrar] Starting registrar module Apr 29 23:55:32.218777 amazon-ssm-agent[2000]: 2025-04-29 23:55:31 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Apr 29 23:55:32.218903 amazon-ssm-agent[2000]: 2025-04-29 23:55:32 INFO [EC2Identity] EC2 registration was successful. Apr 29 23:55:32.219014 amazon-ssm-agent[2000]: 2025-04-29 23:55:32 INFO [CredentialRefresher] credentialRefresher has started Apr 29 23:55:32.219231 amazon-ssm-agent[2000]: 2025-04-29 23:55:32 INFO [CredentialRefresher] Starting credentials refresher loop Apr 29 23:55:32.219231 amazon-ssm-agent[2000]: 2025-04-29 23:55:32 INFO EC2RoleProvider Successfully connected with instance profile role credentials Apr 29 23:55:32.287021 amazon-ssm-agent[2000]: 2025-04-29 23:55:32 INFO [CredentialRefresher] Next credential rotation will be in 30.958294050133333 minutes Apr 29 23:55:33.250162 amazon-ssm-agent[2000]: 2025-04-29 23:55:33 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Apr 29 23:55:33.322336 ntpd[1852]: Listen normally on 6 eth0 [fe80::462:ffff:fe38:a8b9%2]:123 Apr 29 23:55:33.324245 ntpd[1852]: 29 Apr 23:55:33 ntpd[1852]: Listen normally on 6 eth0 [fe80::462:ffff:fe38:a8b9%2]:123 Apr 29 23:55:33.352260 amazon-ssm-agent[2000]: 2025-04-29 23:55:33 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2088) started Apr 29 23:55:33.452910 amazon-ssm-agent[2000]: 2025-04-29 23:55:33 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Apr 29 23:55:33.665429 sshd_keygen[1886]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 29 23:55:33.706317 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 29 23:55:33.716298 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 29 23:55:33.739149 systemd[1]: issuegen.service: Deactivated successfully. Apr 29 23:55:33.739676 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 29 23:55:33.754276 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 29 23:55:33.777771 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 29 23:55:33.791375 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 29 23:55:33.807291 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Apr 29 23:55:33.810458 systemd[1]: Reached target getty.target - Login Prompts. Apr 29 23:55:33.812697 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 29 23:55:33.815591 systemd[1]: Startup finished in 1.109s (kernel) + 6.550s (initrd) + 8.511s (userspace) = 16.171s. Apr 29 23:55:33.878441 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 29 23:55:33.890292 systemd[1]: Started sshd@0-172.31.31.51:22-139.178.89.65:59984.service - OpenSSH per-connection server daemon (139.178.89.65:59984). Apr 29 23:55:34.180480 sshd[2119]: Accepted publickey for core from 139.178.89.65 port 59984 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:55:34.184473 sshd-session[2119]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:55:34.206631 systemd-logind[1856]: New session 1 of user core. Apr 29 23:55:34.208604 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 29 23:55:34.214297 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 29 23:55:34.252538 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 29 23:55:34.260510 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 29 23:55:34.280367 (systemd)[2123]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 29 23:55:34.509930 systemd[2123]: Queued start job for default target default.target. Apr 29 23:55:34.518791 systemd[2123]: Created slice app.slice - User Application Slice. Apr 29 23:55:34.518887 systemd[2123]: Reached target paths.target - Paths. Apr 29 23:55:34.518919 systemd[2123]: Reached target timers.target - Timers. Apr 29 23:55:34.521349 systemd[2123]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 29 23:55:34.543327 systemd[2123]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 29 23:55:34.543580 systemd[2123]: Reached target sockets.target - Sockets. Apr 29 23:55:34.543628 systemd[2123]: Reached target basic.target - Basic System. Apr 29 23:55:34.543721 systemd[2123]: Reached target default.target - Main User Target. Apr 29 23:55:34.543787 systemd[2123]: Startup finished in 251ms. Apr 29 23:55:34.544085 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 29 23:55:34.554067 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 29 23:55:34.772421 systemd[1]: Started sshd@1-172.31.31.51:22-139.178.89.65:60000.service - OpenSSH per-connection server daemon (139.178.89.65:60000). Apr 29 23:55:35.062755 sshd[2134]: Accepted publickey for core from 139.178.89.65 port 60000 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:55:35.066089 sshd-session[2134]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:55:35.076902 systemd-logind[1856]: New session 2 of user core. Apr 29 23:55:35.087238 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 29 23:55:35.263009 sshd[2136]: Connection closed by 139.178.89.65 port 60000 Apr 29 23:55:35.263767 sshd-session[2134]: pam_unix(sshd:session): session closed for user core Apr 29 23:55:35.273443 systemd[1]: sshd@1-172.31.31.51:22-139.178.89.65:60000.service: Deactivated successfully. Apr 29 23:55:35.274623 systemd-logind[1856]: Session 2 logged out. Waiting for processes to exit. Apr 29 23:55:35.279788 systemd[1]: session-2.scope: Deactivated successfully. Apr 29 23:55:35.286901 systemd-logind[1856]: Removed session 2. Apr 29 23:55:35.317773 systemd[1]: Started sshd@2-172.31.31.51:22-139.178.89.65:60002.service - OpenSSH per-connection server daemon (139.178.89.65:60002). Apr 29 23:55:35.600302 sshd[2141]: Accepted publickey for core from 139.178.89.65 port 60002 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:55:35.603388 sshd-session[2141]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:55:35.613683 systemd-logind[1856]: New session 3 of user core. Apr 29 23:55:35.621072 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 29 23:55:35.792866 sshd[2143]: Connection closed by 139.178.89.65 port 60002 Apr 29 23:55:35.793642 sshd-session[2141]: pam_unix(sshd:session): session closed for user core Apr 29 23:55:35.800640 systemd[1]: sshd@2-172.31.31.51:22-139.178.89.65:60002.service: Deactivated successfully. Apr 29 23:55:35.803687 systemd[1]: session-3.scope: Deactivated successfully. Apr 29 23:55:35.806040 systemd-logind[1856]: Session 3 logged out. Waiting for processes to exit. Apr 29 23:55:35.808334 systemd-logind[1856]: Removed session 3. Apr 29 23:55:35.853456 systemd[1]: Started sshd@3-172.31.31.51:22-139.178.89.65:60016.service - OpenSSH per-connection server daemon (139.178.89.65:60016). Apr 29 23:55:36.130571 sshd[2148]: Accepted publickey for core from 139.178.89.65 port 60016 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:55:36.133135 sshd-session[2148]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:55:36.140854 systemd-logind[1856]: New session 4 of user core. Apr 29 23:55:36.149075 systemd[1]: Started session-4.scope - Session 4 of User core. Apr 29 23:55:36.333584 sshd[2150]: Connection closed by 139.178.89.65 port 60016 Apr 29 23:55:36.334397 sshd-session[2148]: pam_unix(sshd:session): session closed for user core Apr 29 23:55:36.340440 systemd[1]: sshd@3-172.31.31.51:22-139.178.89.65:60016.service: Deactivated successfully. Apr 29 23:55:36.344436 systemd[1]: session-4.scope: Deactivated successfully. Apr 29 23:55:36.346336 systemd-logind[1856]: Session 4 logged out. Waiting for processes to exit. Apr 29 23:55:36.348393 systemd-logind[1856]: Removed session 4. Apr 29 23:55:36.390317 systemd[1]: Started sshd@4-172.31.31.51:22-139.178.89.65:60028.service - OpenSSH per-connection server daemon (139.178.89.65:60028). Apr 29 23:55:36.668111 sshd[2155]: Accepted publickey for core from 139.178.89.65 port 60028 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:55:36.670538 sshd-session[2155]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:55:36.678679 systemd-logind[1856]: New session 5 of user core. Apr 29 23:55:36.685079 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 29 23:55:36.845047 sudo[2158]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Apr 29 23:55:36.846301 sudo[2158]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:55:36.866941 sudo[2158]: pam_unix(sudo:session): session closed for user root Apr 29 23:55:36.904869 sshd[2157]: Connection closed by 139.178.89.65 port 60028 Apr 29 23:55:36.906608 sshd-session[2155]: pam_unix(sshd:session): session closed for user core Apr 29 23:55:36.915347 systemd[1]: sshd@4-172.31.31.51:22-139.178.89.65:60028.service: Deactivated successfully. Apr 29 23:55:36.920612 systemd[1]: session-5.scope: Deactivated successfully. Apr 29 23:55:36.923390 systemd-logind[1856]: Session 5 logged out. Waiting for processes to exit. Apr 29 23:55:36.926587 systemd-logind[1856]: Removed session 5. Apr 29 23:55:36.964321 systemd[1]: Started sshd@5-172.31.31.51:22-139.178.89.65:50744.service - OpenSSH per-connection server daemon (139.178.89.65:50744). Apr 29 23:55:37.242576 sshd[2163]: Accepted publickey for core from 139.178.89.65 port 50744 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:55:37.245432 sshd-session[2163]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:55:37.253943 systemd-logind[1856]: New session 6 of user core. Apr 29 23:55:37.261069 systemd[1]: Started session-6.scope - Session 6 of User core. Apr 29 23:55:37.409553 sudo[2167]: 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:55:37.410331 sudo[2167]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:55:37.418357 sudo[2167]: pam_unix(sudo:session): session closed for user root Apr 29 23:55:37.431119 sudo[2166]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Apr 29 23:55:37.431737 sudo[2166]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:55:37.457459 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 29 23:55:37.519668 augenrules[2189]: No rules Apr 29 23:55:37.523076 systemd[1]: audit-rules.service: Deactivated successfully. Apr 29 23:55:37.524907 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 29 23:55:37.528735 sudo[2166]: pam_unix(sudo:session): session closed for user root Apr 29 23:55:37.567745 sshd[2165]: Connection closed by 139.178.89.65 port 50744 Apr 29 23:55:37.568397 sshd-session[2163]: pam_unix(sshd:session): session closed for user core Apr 29 23:55:37.575229 systemd-logind[1856]: Session 6 logged out. Waiting for processes to exit. Apr 29 23:55:37.575245 systemd[1]: sshd@5-172.31.31.51:22-139.178.89.65:50744.service: Deactivated successfully. Apr 29 23:55:37.579687 systemd[1]: session-6.scope: Deactivated successfully. Apr 29 23:55:37.583779 systemd-logind[1856]: Removed session 6. Apr 29 23:55:37.630281 systemd[1]: Started sshd@6-172.31.31.51:22-139.178.89.65:50748.service - OpenSSH per-connection server daemon (139.178.89.65:50748). Apr 29 23:55:37.901515 sshd[2197]: Accepted publickey for core from 139.178.89.65 port 50748 ssh2: RSA SHA256:rMShF5lv1krIneOW1i/lrlpFaOnnFxuzLqGDXTZQrzA Apr 29 23:55:37.904827 sshd-session[2197]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:55:37.913128 systemd-logind[1856]: New session 7 of user core. Apr 29 23:55:37.927054 systemd[1]: Started session-7.scope - Session 7 of User core. Apr 29 23:55:38.094224 sshd[2199]: Connection closed by 139.178.89.65 port 50748 Apr 29 23:55:38.095182 sshd-session[2197]: pam_unix(sshd:session): session closed for user core Apr 29 23:55:38.104164 systemd[1]: sshd@6-172.31.31.51:22-139.178.89.65:50748.service: Deactivated successfully. Apr 29 23:55:38.110105 systemd[1]: session-7.scope: Deactivated successfully. Apr 29 23:55:38.111853 systemd-logind[1856]: Session 7 logged out. Waiting for processes to exit. Apr 29 23:55:38.114622 systemd-logind[1856]: Removed session 7. Apr 29 23:55:59.567776 rpc.mountd[2039]: authenticated mount request from 172.31.22.183:789 for /tmp (/tmp) Apr 29 23:56:01.822105 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Apr 29 23:56:10.360613 rpc.mountd[2039]: authenticated unmount request from 172.31.22.183:708 for /tmp (/tmp) Apr 29 23:56:15.658782 update_engine[1858]: I20250429 23:56:15.658598 1858 update_attempter.cc:509] Updating boot flags... Apr 29 23:56:15.732862 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 43 scanned by (udev-worker) (2222) Apr 29 23:56:16.000868 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 43 scanned by (udev-worker) (2213) Apr 29 23:56:16.230021 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 43 scanned by (udev-worker) (2213)