May 9 23:58:23.201849 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] May 9 23:58:23.201919 kernel: Linux version 6.6.89-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Fri May 9 22:39:45 -00 2025 May 9 23:58:23.201955 kernel: KASLR disabled due to lack of seed May 9 23:58:23.201973 kernel: efi: EFI v2.7 by EDK II May 9 23:58:23.201990 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b000a98 MEMRESERVE=0x7852ee18 May 9 23:58:23.202007 kernel: ACPI: Early table checksum verification disabled May 9 23:58:23.202025 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) May 9 23:58:23.202042 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) May 9 23:58:23.202058 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) May 9 23:58:23.202074 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) May 9 23:58:23.202095 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) May 9 23:58:23.202112 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) May 9 23:58:23.202128 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) May 9 23:58:23.202145 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) May 9 23:58:23.202164 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) May 9 23:58:23.202185 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) May 9 23:58:23.202203 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) May 9 23:58:23.202220 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 May 9 23:58:23.202237 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') May 9 23:58:23.202254 kernel: printk: bootconsole [uart0] enabled May 9 23:58:23.202271 kernel: NUMA: Failed to initialise from firmware May 9 23:58:23.202288 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] May 9 23:58:23.202305 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] May 9 23:58:23.202322 kernel: Zone ranges: May 9 23:58:23.202339 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] May 9 23:58:23.202356 kernel: DMA32 empty May 9 23:58:23.202377 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] May 9 23:58:23.202394 kernel: Movable zone start for each node May 9 23:58:23.202411 kernel: Early memory node ranges May 9 23:58:23.202428 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] May 9 23:58:23.202445 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] May 9 23:58:23.202462 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] May 9 23:58:23.202479 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] May 9 23:58:23.202496 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] May 9 23:58:23.202512 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] May 9 23:58:23.202529 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] May 9 23:58:23.202546 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] May 9 23:58:23.202563 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] May 9 23:58:23.202584 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges May 9 23:58:23.202602 kernel: psci: probing for conduit method from ACPI. May 9 23:58:23.202626 kernel: psci: PSCIv1.0 detected in firmware. May 9 23:58:23.202645 kernel: psci: Using standard PSCI v0.2 function IDs May 9 23:58:23.202663 kernel: psci: Trusted OS migration not required May 9 23:58:23.202685 kernel: psci: SMC Calling Convention v1.1 May 9 23:58:23.202703 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 May 9 23:58:23.202721 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 May 9 23:58:23.202739 kernel: pcpu-alloc: [0] 0 [0] 1 May 9 23:58:23.202757 kernel: Detected PIPT I-cache on CPU0 May 9 23:58:23.202774 kernel: CPU features: detected: GIC system register CPU interface May 9 23:58:23.202792 kernel: CPU features: detected: Spectre-v2 May 9 23:58:23.202810 kernel: CPU features: detected: Spectre-v3a May 9 23:58:23.202828 kernel: CPU features: detected: Spectre-BHB May 9 23:58:23.202845 kernel: CPU features: detected: ARM erratum 1742098 May 9 23:58:23.202863 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 May 9 23:58:23.202885 kernel: alternatives: applying boot alternatives May 9 23:58:23.204974 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=6ddfb314c5db7ed82ab49390a2bb52fe12211605ed2a5a27fb38ec34b3cca5b4 May 9 23:58:23.205008 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 9 23:58:23.205028 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 9 23:58:23.205048 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 9 23:58:23.205066 kernel: Fallback order for Node 0: 0 May 9 23:58:23.205085 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 May 9 23:58:23.205104 kernel: Policy zone: Normal May 9 23:58:23.205122 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 9 23:58:23.205141 kernel: software IO TLB: area num 2. May 9 23:58:23.205159 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) May 9 23:58:23.205188 kernel: Memory: 3820088K/4030464K available (10304K kernel code, 2186K rwdata, 8104K rodata, 39424K init, 897K bss, 210376K reserved, 0K cma-reserved) May 9 23:58:23.205206 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 May 9 23:58:23.205224 kernel: rcu: Preemptible hierarchical RCU implementation. May 9 23:58:23.205243 kernel: rcu: RCU event tracing is enabled. May 9 23:58:23.205261 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. May 9 23:58:23.205280 kernel: Trampoline variant of Tasks RCU enabled. May 9 23:58:23.205298 kernel: Tracing variant of Tasks RCU enabled. May 9 23:58:23.205316 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 9 23:58:23.205334 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 May 9 23:58:23.205352 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 May 9 23:58:23.205369 kernel: GICv3: 96 SPIs implemented May 9 23:58:23.205392 kernel: GICv3: 0 Extended SPIs implemented May 9 23:58:23.205410 kernel: Root IRQ handler: gic_handle_irq May 9 23:58:23.205428 kernel: GICv3: GICv3 features: 16 PPIs May 9 23:58:23.205446 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 May 9 23:58:23.205464 kernel: ITS [mem 0x10080000-0x1009ffff] May 9 23:58:23.205482 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) May 9 23:58:23.205500 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) May 9 23:58:23.205518 kernel: GICv3: using LPI property table @0x00000004000d0000 May 9 23:58:23.205536 kernel: ITS: Using hypervisor restricted LPI range [128] May 9 23:58:23.205554 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 May 9 23:58:23.205572 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 9 23:58:23.205590 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). May 9 23:58:23.205612 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns May 9 23:58:23.205630 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns May 9 23:58:23.205648 kernel: Console: colour dummy device 80x25 May 9 23:58:23.205667 kernel: printk: console [tty1] enabled May 9 23:58:23.205685 kernel: ACPI: Core revision 20230628 May 9 23:58:23.205704 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) May 9 23:58:23.205722 kernel: pid_max: default: 32768 minimum: 301 May 9 23:58:23.205741 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity May 9 23:58:23.205759 kernel: landlock: Up and running. May 9 23:58:23.205782 kernel: SELinux: Initializing. May 9 23:58:23.205801 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 9 23:58:23.205819 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 9 23:58:23.205838 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 9 23:58:23.205856 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 9 23:58:23.205874 kernel: rcu: Hierarchical SRCU implementation. May 9 23:58:23.205893 kernel: rcu: Max phase no-delay instances is 400. May 9 23:58:23.205937 kernel: Platform MSI: ITS@0x10080000 domain created May 9 23:58:23.205957 kernel: PCI/MSI: ITS@0x10080000 domain created May 9 23:58:23.205981 kernel: Remapping and enabling EFI services. May 9 23:58:23.206000 kernel: smp: Bringing up secondary CPUs ... May 9 23:58:23.206019 kernel: Detected PIPT I-cache on CPU1 May 9 23:58:23.206038 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 May 9 23:58:23.206056 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 May 9 23:58:23.206075 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] May 9 23:58:23.206093 kernel: smp: Brought up 1 node, 2 CPUs May 9 23:58:23.206111 kernel: SMP: Total of 2 processors activated. May 9 23:58:23.206130 kernel: CPU features: detected: 32-bit EL0 Support May 9 23:58:23.206152 kernel: CPU features: detected: 32-bit EL1 Support May 9 23:58:23.206171 kernel: CPU features: detected: CRC32 instructions May 9 23:58:23.206189 kernel: CPU: All CPU(s) started at EL1 May 9 23:58:23.206219 kernel: alternatives: applying system-wide alternatives May 9 23:58:23.206242 kernel: devtmpfs: initialized May 9 23:58:23.206262 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 9 23:58:23.206281 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) May 9 23:58:23.206300 kernel: pinctrl core: initialized pinctrl subsystem May 9 23:58:23.206318 kernel: SMBIOS 3.0.0 present. May 9 23:58:23.206337 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 May 9 23:58:23.206361 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 9 23:58:23.206381 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations May 9 23:58:23.206400 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations May 9 23:58:23.206419 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations May 9 23:58:23.206438 kernel: audit: initializing netlink subsys (disabled) May 9 23:58:23.206458 kernel: audit: type=2000 audit(0.302:1): state=initialized audit_enabled=0 res=1 May 9 23:58:23.206477 kernel: thermal_sys: Registered thermal governor 'step_wise' May 9 23:58:23.206500 kernel: cpuidle: using governor menu May 9 23:58:23.206520 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. May 9 23:58:23.206539 kernel: ASID allocator initialised with 65536 entries May 9 23:58:23.206558 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 9 23:58:23.206577 kernel: Serial: AMBA PL011 UART driver May 9 23:58:23.206596 kernel: Modules: 17488 pages in range for non-PLT usage May 9 23:58:23.206615 kernel: Modules: 509008 pages in range for PLT usage May 9 23:58:23.206634 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 9 23:58:23.206653 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page May 9 23:58:23.206677 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages May 9 23:58:23.206696 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page May 9 23:58:23.206715 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 9 23:58:23.206734 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page May 9 23:58:23.206753 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages May 9 23:58:23.206772 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page May 9 23:58:23.206791 kernel: ACPI: Added _OSI(Module Device) May 9 23:58:23.206810 kernel: ACPI: Added _OSI(Processor Device) May 9 23:58:23.206829 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 9 23:58:23.206852 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 9 23:58:23.206872 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 9 23:58:23.206891 kernel: ACPI: Interpreter enabled May 9 23:58:23.209047 kernel: ACPI: Using GIC for interrupt routing May 9 23:58:23.209074 kernel: ACPI: MCFG table detected, 1 entries May 9 23:58:23.209095 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) May 9 23:58:23.211627 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 9 23:58:23.211860 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] May 9 23:58:23.212136 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] May 9 23:58:23.212350 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 May 9 23:58:23.212580 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] May 9 23:58:23.212609 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] May 9 23:58:23.212629 kernel: acpiphp: Slot [1] registered May 9 23:58:23.212649 kernel: acpiphp: Slot [2] registered May 9 23:58:23.212668 kernel: acpiphp: Slot [3] registered May 9 23:58:23.212687 kernel: acpiphp: Slot [4] registered May 9 23:58:23.212714 kernel: acpiphp: Slot [5] registered May 9 23:58:23.212733 kernel: acpiphp: Slot [6] registered May 9 23:58:23.212752 kernel: acpiphp: Slot [7] registered May 9 23:58:23.212771 kernel: acpiphp: Slot [8] registered May 9 23:58:23.212790 kernel: acpiphp: Slot [9] registered May 9 23:58:23.212809 kernel: acpiphp: Slot [10] registered May 9 23:58:23.212828 kernel: acpiphp: Slot [11] registered May 9 23:58:23.212846 kernel: acpiphp: Slot [12] registered May 9 23:58:23.212865 kernel: acpiphp: Slot [13] registered May 9 23:58:23.212884 kernel: acpiphp: Slot [14] registered May 9 23:58:23.212932 kernel: acpiphp: Slot [15] registered May 9 23:58:23.212953 kernel: acpiphp: Slot [16] registered May 9 23:58:23.212972 kernel: acpiphp: Slot [17] registered May 9 23:58:23.212993 kernel: acpiphp: Slot [18] registered May 9 23:58:23.213012 kernel: acpiphp: Slot [19] registered May 9 23:58:23.213032 kernel: acpiphp: Slot [20] registered May 9 23:58:23.213051 kernel: acpiphp: Slot [21] registered May 9 23:58:23.213070 kernel: acpiphp: Slot [22] registered May 9 23:58:23.213089 kernel: acpiphp: Slot [23] registered May 9 23:58:23.213113 kernel: acpiphp: Slot [24] registered May 9 23:58:23.213133 kernel: acpiphp: Slot [25] registered May 9 23:58:23.213152 kernel: acpiphp: Slot [26] registered May 9 23:58:23.213170 kernel: acpiphp: Slot [27] registered May 9 23:58:23.213190 kernel: acpiphp: Slot [28] registered May 9 23:58:23.213208 kernel: acpiphp: Slot [29] registered May 9 23:58:23.213227 kernel: acpiphp: Slot [30] registered May 9 23:58:23.213246 kernel: acpiphp: Slot [31] registered May 9 23:58:23.213265 kernel: PCI host bridge to bus 0000:00 May 9 23:58:23.213492 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] May 9 23:58:23.213686 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] May 9 23:58:23.213873 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] May 9 23:58:23.217171 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] May 9 23:58:23.217434 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 May 9 23:58:23.217683 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 May 9 23:58:23.219965 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] May 9 23:58:23.220276 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 May 9 23:58:23.220490 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] May 9 23:58:23.220722 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold May 9 23:58:23.220983 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 May 9 23:58:23.221241 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] May 9 23:58:23.221472 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] May 9 23:58:23.221702 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] May 9 23:58:23.221990 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold May 9 23:58:23.222226 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] May 9 23:58:23.222439 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] May 9 23:58:23.222670 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] May 9 23:58:23.222889 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] May 9 23:58:23.226407 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] May 9 23:58:23.226625 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] May 9 23:58:23.226815 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] May 9 23:58:23.229091 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] May 9 23:58:23.229134 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 May 9 23:58:23.229155 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 May 9 23:58:23.229176 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 May 9 23:58:23.229195 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 May 9 23:58:23.229215 kernel: iommu: Default domain type: Translated May 9 23:58:23.229235 kernel: iommu: DMA domain TLB invalidation policy: strict mode May 9 23:58:23.229264 kernel: efivars: Registered efivars operations May 9 23:58:23.229283 kernel: vgaarb: loaded May 9 23:58:23.229303 kernel: clocksource: Switched to clocksource arch_sys_counter May 9 23:58:23.229322 kernel: VFS: Disk quotas dquot_6.6.0 May 9 23:58:23.229341 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 9 23:58:23.229361 kernel: pnp: PnP ACPI init May 9 23:58:23.229593 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved May 9 23:58:23.229701 kernel: pnp: PnP ACPI: found 1 devices May 9 23:58:23.230333 kernel: NET: Registered PF_INET protocol family May 9 23:58:23.230646 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 9 23:58:23.232942 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 9 23:58:23.232982 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 9 23:58:23.233003 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 9 23:58:23.233023 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 9 23:58:23.233043 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 9 23:58:23.233063 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 9 23:58:23.233083 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 9 23:58:23.233111 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 9 23:58:23.233130 kernel: PCI: CLS 0 bytes, default 64 May 9 23:58:23.233149 kernel: kvm [1]: HYP mode not available May 9 23:58:23.233168 kernel: Initialise system trusted keyrings May 9 23:58:23.233188 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 9 23:58:23.233207 kernel: Key type asymmetric registered May 9 23:58:23.233226 kernel: Asymmetric key parser 'x509' registered May 9 23:58:23.233245 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 9 23:58:23.233264 kernel: io scheduler mq-deadline registered May 9 23:58:23.233288 kernel: io scheduler kyber registered May 9 23:58:23.233307 kernel: io scheduler bfq registered May 9 23:58:23.233566 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered May 9 23:58:23.233598 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 May 9 23:58:23.233618 kernel: ACPI: button: Power Button [PWRB] May 9 23:58:23.233637 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 May 9 23:58:23.233657 kernel: ACPI: button: Sleep Button [SLPB] May 9 23:58:23.233676 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 9 23:58:23.233702 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 May 9 23:58:23.233963 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) May 9 23:58:23.233995 kernel: printk: console [ttyS0] disabled May 9 23:58:23.234016 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A May 9 23:58:23.234036 kernel: printk: console [ttyS0] enabled May 9 23:58:23.234055 kernel: printk: bootconsole [uart0] disabled May 9 23:58:23.234074 kernel: thunder_xcv, ver 1.0 May 9 23:58:23.234094 kernel: thunder_bgx, ver 1.0 May 9 23:58:23.234112 kernel: nicpf, ver 1.0 May 9 23:58:23.234138 kernel: nicvf, ver 1.0 May 9 23:58:23.234373 kernel: rtc-efi rtc-efi.0: registered as rtc0 May 9 23:58:23.234577 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-05-09T23:58:22 UTC (1746835102) May 9 23:58:23.234604 kernel: hid: raw HID events driver (C) Jiri Kosina May 9 23:58:23.234625 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available May 9 23:58:23.234645 kernel: watchdog: Delayed init of the lockup detector failed: -19 May 9 23:58:23.234664 kernel: watchdog: Hard watchdog permanently disabled May 9 23:58:23.234683 kernel: NET: Registered PF_INET6 protocol family May 9 23:58:23.234708 kernel: Segment Routing with IPv6 May 9 23:58:23.234727 kernel: In-situ OAM (IOAM) with IPv6 May 9 23:58:23.234746 kernel: NET: Registered PF_PACKET protocol family May 9 23:58:23.234765 kernel: Key type dns_resolver registered May 9 23:58:23.234784 kernel: registered taskstats version 1 May 9 23:58:23.234803 kernel: Loading compiled-in X.509 certificates May 9 23:58:23.234822 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.89-flatcar: 02a1572fa4e3e92c40cffc658d8dbcab2e5537ff' May 9 23:58:23.234842 kernel: Key type .fscrypt registered May 9 23:58:23.234861 kernel: Key type fscrypt-provisioning registered May 9 23:58:23.234885 kernel: ima: No TPM chip found, activating TPM-bypass! May 9 23:58:23.235982 kernel: ima: Allocated hash algorithm: sha1 May 9 23:58:23.236008 kernel: ima: No architecture policies found May 9 23:58:23.236029 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) May 9 23:58:23.236050 kernel: clk: Disabling unused clocks May 9 23:58:23.236069 kernel: Freeing unused kernel memory: 39424K May 9 23:58:23.236089 kernel: Run /init as init process May 9 23:58:23.236108 kernel: with arguments: May 9 23:58:23.236127 kernel: /init May 9 23:58:23.236146 kernel: with environment: May 9 23:58:23.236174 kernel: HOME=/ May 9 23:58:23.236194 kernel: TERM=linux May 9 23:58:23.236213 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 9 23:58:23.236237 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) May 9 23:58:23.236262 systemd[1]: Detected virtualization amazon. May 9 23:58:23.236284 systemd[1]: Detected architecture arm64. May 9 23:58:23.236304 systemd[1]: Running in initrd. May 9 23:58:23.236330 systemd[1]: No hostname configured, using default hostname. May 9 23:58:23.236351 systemd[1]: Hostname set to . May 9 23:58:23.236373 systemd[1]: Initializing machine ID from VM UUID. May 9 23:58:23.236393 systemd[1]: Queued start job for default target initrd.target. May 9 23:58:23.236415 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 9 23:58:23.236436 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 9 23:58:23.236458 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 9 23:58:23.236480 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 9 23:58:23.236507 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 9 23:58:23.236549 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 9 23:58:23.236576 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 9 23:58:23.236599 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 9 23:58:23.236620 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 9 23:58:23.236642 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 9 23:58:23.236663 systemd[1]: Reached target paths.target - Path Units. May 9 23:58:23.236691 systemd[1]: Reached target slices.target - Slice Units. May 9 23:58:23.236712 systemd[1]: Reached target swap.target - Swaps. May 9 23:58:23.236733 systemd[1]: Reached target timers.target - Timer Units. May 9 23:58:23.236754 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 9 23:58:23.236775 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 9 23:58:23.236797 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 9 23:58:23.236818 systemd[1]: Listening on systemd-journald.socket - Journal Socket. May 9 23:58:23.236840 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 9 23:58:23.236861 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 9 23:58:23.236887 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 9 23:58:23.238351 systemd[1]: Reached target sockets.target - Socket Units. May 9 23:58:23.238378 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 9 23:58:23.238400 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 9 23:58:23.238422 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 9 23:58:23.238443 systemd[1]: Starting systemd-fsck-usr.service... May 9 23:58:23.238464 systemd[1]: Starting systemd-journald.service - Journal Service... May 9 23:58:23.238485 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 9 23:58:23.238514 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 9 23:58:23.238536 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 9 23:58:23.238557 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 9 23:58:23.238577 systemd[1]: Finished systemd-fsck-usr.service. May 9 23:58:23.238600 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 9 23:58:23.238671 systemd-journald[251]: Collecting audit messages is disabled. May 9 23:58:23.241338 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 9 23:58:23.241678 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 9 23:58:23.242389 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 9 23:58:23.242419 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 9 23:58:23.242446 systemd-journald[251]: Journal started May 9 23:58:23.242490 systemd-journald[251]: Runtime Journal (/run/log/journal/ec2d1ef15685266a3c7a982036f301b9) is 8.0M, max 75.3M, 67.3M free. May 9 23:58:23.207156 systemd-modules-load[252]: Inserted module 'overlay' May 9 23:58:23.251272 systemd[1]: Started systemd-journald.service - Journal Service. May 9 23:58:23.251345 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 9 23:58:23.257162 systemd-modules-load[252]: Inserted module 'br_netfilter' May 9 23:58:23.259046 kernel: Bridge firewalling registered May 9 23:58:23.265406 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 9 23:58:23.269798 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 9 23:58:23.295327 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 9 23:58:23.306262 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 9 23:58:23.311829 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 9 23:58:23.320539 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 9 23:58:23.339022 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 9 23:58:23.355586 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 9 23:58:23.376939 dracut-cmdline[284]: dracut-dracut-053 May 9 23:58:23.383214 dracut-cmdline[284]: 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=6ddfb314c5db7ed82ab49390a2bb52fe12211605ed2a5a27fb38ec34b3cca5b4 May 9 23:58:23.401201 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 9 23:58:23.452983 systemd-resolved[296]: Positive Trust Anchors: May 9 23:58:23.454993 systemd-resolved[296]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 9 23:58:23.458162 systemd-resolved[296]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test May 9 23:58:23.535941 kernel: SCSI subsystem initialized May 9 23:58:23.543939 kernel: Loading iSCSI transport class v2.0-870. May 9 23:58:23.556956 kernel: iscsi: registered transport (tcp) May 9 23:58:23.579955 kernel: iscsi: registered transport (qla4xxx) May 9 23:58:23.580028 kernel: QLogic iSCSI HBA Driver May 9 23:58:23.677955 kernel: random: crng init done May 9 23:58:23.678345 systemd-resolved[296]: Defaulting to hostname 'linux'. May 9 23:58:23.682288 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 9 23:58:23.684781 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 9 23:58:23.712012 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 9 23:58:23.722223 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 9 23:58:23.772030 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 9 23:58:23.772173 kernel: device-mapper: uevent: version 1.0.3 May 9 23:58:23.772214 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com May 9 23:58:23.843977 kernel: raid6: neonx8 gen() 6761 MB/s May 9 23:58:23.860953 kernel: raid6: neonx4 gen() 6536 MB/s May 9 23:58:23.877951 kernel: raid6: neonx2 gen() 5453 MB/s May 9 23:58:23.894964 kernel: raid6: neonx1 gen() 3941 MB/s May 9 23:58:23.911955 kernel: raid6: int64x8 gen() 3751 MB/s May 9 23:58:23.928960 kernel: raid6: int64x4 gen() 3681 MB/s May 9 23:58:23.945962 kernel: raid6: int64x2 gen() 3590 MB/s May 9 23:58:23.963805 kernel: raid6: int64x1 gen() 2759 MB/s May 9 23:58:23.963922 kernel: raid6: using algorithm neonx8 gen() 6761 MB/s May 9 23:58:23.981788 kernel: raid6: .... xor() 4831 MB/s, rmw enabled May 9 23:58:23.981881 kernel: raid6: using neon recovery algorithm May 9 23:58:23.991219 kernel: xor: measuring software checksum speed May 9 23:58:23.991301 kernel: 8regs : 10904 MB/sec May 9 23:58:23.992381 kernel: 32regs : 11851 MB/sec May 9 23:58:23.993646 kernel: arm64_neon : 9146 MB/sec May 9 23:58:23.993719 kernel: xor: using function: 32regs (11851 MB/sec) May 9 23:58:24.081996 kernel: Btrfs loaded, zoned=no, fsverity=no May 9 23:58:24.103138 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 9 23:58:24.113222 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 9 23:58:24.155279 systemd-udevd[471]: Using default interface naming scheme 'v255'. May 9 23:58:24.163972 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 9 23:58:24.184527 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 9 23:58:24.213226 dracut-pre-trigger[482]: rd.md=0: removing MD RAID activation May 9 23:58:24.270285 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 9 23:58:24.286182 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 9 23:58:24.399586 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 9 23:58:24.410228 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 9 23:58:24.458971 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 9 23:58:24.464821 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 9 23:58:24.469395 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 9 23:58:24.471810 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 9 23:58:24.486531 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 9 23:58:24.533120 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 9 23:58:24.586466 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 May 9 23:58:24.586532 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) May 9 23:58:24.607677 kernel: ena 0000:00:05.0: ENA device version: 0.10 May 9 23:58:24.608050 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 May 9 23:58:24.615932 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:b9:da:08:a5:27 May 9 23:58:24.621177 (udev-worker)[528]: Network interface NamePolicy= disabled on kernel command line. May 9 23:58:24.630519 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 9 23:58:24.633705 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 May 9 23:58:24.630982 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 9 23:58:24.641123 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 9 23:58:24.650370 kernel: nvme nvme0: pci function 0000:00:04.0 May 9 23:58:24.645665 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 9 23:58:24.645953 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 9 23:58:24.648221 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 9 23:58:24.663977 kernel: nvme nvme0: 2/0/0 default/read/poll queues May 9 23:58:24.664981 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 9 23:58:24.679108 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. May 9 23:58:24.679161 kernel: GPT:9289727 != 16777215 May 9 23:58:24.679187 kernel: GPT:Alternate GPT header not at the end of the disk. May 9 23:58:24.679213 kernel: GPT:9289727 != 16777215 May 9 23:58:24.681868 kernel: GPT: Use GNU Parted to correct GPT errors. May 9 23:58:24.681933 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 9 23:58:24.699980 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 9 23:58:24.710251 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 9 23:58:24.761542 kernel: BTRFS: device fsid 7278434d-1c51-4098-9ab9-92db46b8a354 devid 1 transid 41 /dev/nvme0n1p3 scanned by (udev-worker) (543) May 9 23:58:24.763010 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 9 23:58:24.800006 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by (udev-worker) (524) May 9 23:58:24.848095 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. May 9 23:58:24.882463 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. May 9 23:58:24.899672 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. May 9 23:58:24.905596 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. May 9 23:58:24.942987 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. May 9 23:58:24.954178 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 9 23:58:24.970167 disk-uuid[661]: Primary Header is updated. May 9 23:58:24.970167 disk-uuid[661]: Secondary Entries is updated. May 9 23:58:24.970167 disk-uuid[661]: Secondary Header is updated. May 9 23:58:24.979983 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 9 23:58:24.986947 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 9 23:58:24.996938 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 9 23:58:25.999936 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 9 23:58:26.001426 disk-uuid[662]: The operation has completed successfully. May 9 23:58:26.185078 systemd[1]: disk-uuid.service: Deactivated successfully. May 9 23:58:26.185662 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 9 23:58:26.230151 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 9 23:58:26.239010 sh[1005]: Success May 9 23:58:26.266954 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" May 9 23:58:26.384290 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 9 23:58:26.392041 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 9 23:58:26.396501 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 9 23:58:26.432076 kernel: BTRFS info (device dm-0): first mount of filesystem 7278434d-1c51-4098-9ab9-92db46b8a354 May 9 23:58:26.432140 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm May 9 23:58:26.433855 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead May 9 23:58:26.435115 kernel: BTRFS info (device dm-0): disabling log replay at mount time May 9 23:58:26.436149 kernel: BTRFS info (device dm-0): using free space tree May 9 23:58:26.460918 kernel: BTRFS info (device dm-0): enabling ssd optimizations May 9 23:58:26.475717 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 9 23:58:26.479083 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 9 23:58:26.496249 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 9 23:58:26.503190 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 9 23:58:26.534223 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 3b69b342-5bf7-4a79-8c13-5043d2a95a48 May 9 23:58:26.534305 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm May 9 23:58:26.534338 kernel: BTRFS info (device nvme0n1p6): using free space tree May 9 23:58:26.543932 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations May 9 23:58:26.560380 systemd[1]: mnt-oem.mount: Deactivated successfully. May 9 23:58:26.562928 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 3b69b342-5bf7-4a79-8c13-5043d2a95a48 May 9 23:58:26.574817 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 9 23:58:26.585326 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 9 23:58:26.691967 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 9 23:58:26.710520 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 9 23:58:26.764065 systemd-networkd[1200]: lo: Link UP May 9 23:58:26.764085 systemd-networkd[1200]: lo: Gained carrier May 9 23:58:26.767796 systemd-networkd[1200]: Enumeration completed May 9 23:58:26.768299 systemd[1]: Started systemd-networkd.service - Network Configuration. May 9 23:58:26.771709 systemd-networkd[1200]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 9 23:58:26.771716 systemd-networkd[1200]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 9 23:58:26.772816 systemd[1]: Reached target network.target - Network. May 9 23:58:26.791932 systemd-networkd[1200]: eth0: Link UP May 9 23:58:26.791940 systemd-networkd[1200]: eth0: Gained carrier May 9 23:58:26.791960 systemd-networkd[1200]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 9 23:58:26.806468 ignition[1114]: Ignition 2.19.0 May 9 23:58:26.807301 ignition[1114]: Stage: fetch-offline May 9 23:58:26.808260 ignition[1114]: no configs at "/usr/lib/ignition/base.d" May 9 23:58:26.809468 systemd-networkd[1200]: eth0: DHCPv4 address 172.31.25.130/20, gateway 172.31.16.1 acquired from 172.31.16.1 May 9 23:58:26.808582 ignition[1114]: no config dir at "/usr/lib/ignition/base.platform.d/aws" May 9 23:58:26.813879 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 9 23:58:26.809750 ignition[1114]: Ignition finished successfully May 9 23:58:26.830309 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... May 9 23:58:26.867003 ignition[1208]: Ignition 2.19.0 May 9 23:58:26.867032 ignition[1208]: Stage: fetch May 9 23:58:26.868627 ignition[1208]: no configs at "/usr/lib/ignition/base.d" May 9 23:58:26.868653 ignition[1208]: no config dir at "/usr/lib/ignition/base.platform.d/aws" May 9 23:58:26.868808 ignition[1208]: PUT http://169.254.169.254/latest/api/token: attempt #1 May 9 23:58:26.894291 ignition[1208]: PUT result: OK May 9 23:58:26.897233 ignition[1208]: parsed url from cmdline: "" May 9 23:58:26.897253 ignition[1208]: no config URL provided May 9 23:58:26.897269 ignition[1208]: reading system config file "/usr/lib/ignition/user.ign" May 9 23:58:26.897295 ignition[1208]: no config at "/usr/lib/ignition/user.ign" May 9 23:58:26.897329 ignition[1208]: PUT http://169.254.169.254/latest/api/token: attempt #1 May 9 23:58:26.898891 ignition[1208]: PUT result: OK May 9 23:58:26.909681 unknown[1208]: fetched base config from "system" May 9 23:58:26.898994 ignition[1208]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 May 9 23:58:26.909697 unknown[1208]: fetched base config from "system" May 9 23:58:26.902891 ignition[1208]: GET result: OK May 9 23:58:26.909710 unknown[1208]: fetched user config from "aws" May 9 23:58:26.902981 ignition[1208]: parsing config with SHA512: f3fa2895958c249863f2a6c839d8370163806c310550c2909f2ec58491e546bab1ba3bb92e4a0ea4d44db507fa161a73c696e7f3f2db4678f3f2398a37b3a489 May 9 23:58:26.910026 ignition[1208]: fetch: fetch complete May 9 23:58:26.910038 ignition[1208]: fetch: fetch passed May 9 23:58:26.910126 ignition[1208]: Ignition finished successfully May 9 23:58:26.925695 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). May 9 23:58:26.949240 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 9 23:58:26.974240 ignition[1215]: Ignition 2.19.0 May 9 23:58:26.974263 ignition[1215]: Stage: kargs May 9 23:58:26.974873 ignition[1215]: no configs at "/usr/lib/ignition/base.d" May 9 23:58:26.975613 ignition[1215]: no config dir at "/usr/lib/ignition/base.platform.d/aws" May 9 23:58:26.975795 ignition[1215]: PUT http://169.254.169.254/latest/api/token: attempt #1 May 9 23:58:26.978577 ignition[1215]: PUT result: OK May 9 23:58:26.986513 ignition[1215]: kargs: kargs passed May 9 23:58:26.986600 ignition[1215]: Ignition finished successfully May 9 23:58:26.992525 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 9 23:58:27.013334 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 9 23:58:27.037206 ignition[1221]: Ignition 2.19.0 May 9 23:58:27.037704 ignition[1221]: Stage: disks May 9 23:58:27.038386 ignition[1221]: no configs at "/usr/lib/ignition/base.d" May 9 23:58:27.038427 ignition[1221]: no config dir at "/usr/lib/ignition/base.platform.d/aws" May 9 23:58:27.038579 ignition[1221]: PUT http://169.254.169.254/latest/api/token: attempt #1 May 9 23:58:27.042211 ignition[1221]: PUT result: OK May 9 23:58:27.051094 ignition[1221]: disks: disks passed May 9 23:58:27.051189 ignition[1221]: Ignition finished successfully May 9 23:58:27.055701 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 9 23:58:27.059686 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 9 23:58:27.063756 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 9 23:58:27.066146 systemd[1]: Reached target local-fs.target - Local File Systems. May 9 23:58:27.068101 systemd[1]: Reached target sysinit.target - System Initialization. May 9 23:58:27.070074 systemd[1]: Reached target basic.target - Basic System. May 9 23:58:27.098300 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 9 23:58:27.151926 systemd-fsck[1229]: ROOT: clean, 14/553520 files, 52654/553472 blocks May 9 23:58:27.156126 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 9 23:58:27.165328 systemd[1]: Mounting sysroot.mount - /sysroot... May 9 23:58:27.254929 kernel: EXT4-fs (nvme0n1p9): mounted filesystem ffdb9517-5190-4050-8f70-de9d48dc1858 r/w with ordered data mode. Quota mode: none. May 9 23:58:27.256302 systemd[1]: Mounted sysroot.mount - /sysroot. May 9 23:58:27.262627 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 9 23:58:27.280149 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 9 23:58:27.291189 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 9 23:58:27.296013 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 9 23:58:27.301046 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 9 23:58:27.305495 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 9 23:58:27.314256 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 9 23:58:27.323617 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 9 23:58:27.344933 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/nvme0n1p6 scanned by mount (1248) May 9 23:58:27.351548 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 3b69b342-5bf7-4a79-8c13-5043d2a95a48 May 9 23:58:27.351627 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm May 9 23:58:27.353526 kernel: BTRFS info (device nvme0n1p6): using free space tree May 9 23:58:27.367939 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations May 9 23:58:27.372007 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 9 23:58:27.469072 initrd-setup-root[1272]: cut: /sysroot/etc/passwd: No such file or directory May 9 23:58:27.479966 initrd-setup-root[1279]: cut: /sysroot/etc/group: No such file or directory May 9 23:58:27.489785 initrd-setup-root[1286]: cut: /sysroot/etc/shadow: No such file or directory May 9 23:58:27.498887 initrd-setup-root[1293]: cut: /sysroot/etc/gshadow: No such file or directory May 9 23:58:27.656437 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 9 23:58:27.667114 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 9 23:58:27.681405 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 9 23:58:27.697709 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 9 23:58:27.700945 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 3b69b342-5bf7-4a79-8c13-5043d2a95a48 May 9 23:58:27.740004 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 9 23:58:27.749806 ignition[1360]: INFO : Ignition 2.19.0 May 9 23:58:27.749806 ignition[1360]: INFO : Stage: mount May 9 23:58:27.753241 ignition[1360]: INFO : no configs at "/usr/lib/ignition/base.d" May 9 23:58:27.753241 ignition[1360]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" May 9 23:58:27.757589 ignition[1360]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 May 9 23:58:27.760772 ignition[1360]: INFO : PUT result: OK May 9 23:58:27.765354 ignition[1360]: INFO : mount: mount passed May 9 23:58:27.765354 ignition[1360]: INFO : Ignition finished successfully May 9 23:58:27.771069 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 9 23:58:27.781195 systemd[1]: Starting ignition-files.service - Ignition (files)... May 9 23:58:27.812353 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 9 23:58:27.846074 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by mount (1372) May 9 23:58:27.846138 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 3b69b342-5bf7-4a79-8c13-5043d2a95a48 May 9 23:58:27.849338 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm May 9 23:58:27.850552 kernel: BTRFS info (device nvme0n1p6): using free space tree May 9 23:58:27.856948 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations May 9 23:58:27.860304 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 9 23:58:27.899950 ignition[1389]: INFO : Ignition 2.19.0 May 9 23:58:27.899950 ignition[1389]: INFO : Stage: files May 9 23:58:27.904326 ignition[1389]: INFO : no configs at "/usr/lib/ignition/base.d" May 9 23:58:27.904326 ignition[1389]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" May 9 23:58:27.904326 ignition[1389]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 May 9 23:58:27.911049 ignition[1389]: INFO : PUT result: OK May 9 23:58:27.915461 ignition[1389]: DEBUG : files: compiled without relabeling support, skipping May 9 23:58:27.918336 ignition[1389]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 9 23:58:27.918336 ignition[1389]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 9 23:58:27.931170 ignition[1389]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 9 23:58:27.934211 ignition[1389]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 9 23:58:27.937526 unknown[1389]: wrote ssh authorized keys file for user: core May 9 23:58:27.939985 ignition[1389]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 9 23:58:27.945541 ignition[1389]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 9 23:58:27.949125 ignition[1389]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 9 23:58:27.949125 ignition[1389]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" May 9 23:58:27.949125 ignition[1389]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" May 9 23:58:27.949125 ignition[1389]: INFO : files: files passed May 9 23:58:27.949125 ignition[1389]: INFO : Ignition finished successfully May 9 23:58:27.966993 systemd[1]: Finished ignition-files.service - Ignition (files). May 9 23:58:27.978272 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 9 23:58:27.987222 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 9 23:58:28.001514 systemd[1]: ignition-quench.service: Deactivated successfully. May 9 23:58:28.003445 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 9 23:58:28.035087 systemd-networkd[1200]: eth0: Gained IPv6LL May 9 23:58:28.047578 initrd-setup-root-after-ignition[1417]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 9 23:58:28.047578 initrd-setup-root-after-ignition[1417]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 9 23:58:28.054189 initrd-setup-root-after-ignition[1421]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 9 23:58:28.062042 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 9 23:58:28.065572 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 9 23:58:28.082383 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 9 23:58:28.153295 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 9 23:58:28.153520 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 9 23:58:28.157530 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 9 23:58:28.166203 systemd[1]: Reached target initrd.target - Initrd Default Target. May 9 23:58:28.168934 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 9 23:58:28.186348 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 9 23:58:28.214580 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 9 23:58:28.228282 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 9 23:58:28.255535 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 9 23:58:28.258422 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 9 23:58:28.262675 systemd[1]: Stopped target timers.target - Timer Units. May 9 23:58:28.268045 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 9 23:58:28.268291 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 9 23:58:28.271205 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 9 23:58:28.279302 systemd[1]: Stopped target basic.target - Basic System. May 9 23:58:28.281242 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 9 23:58:28.284531 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 9 23:58:28.292845 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 9 23:58:28.295861 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 9 23:58:28.298552 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 9 23:58:28.307524 systemd[1]: Stopped target sysinit.target - System Initialization. May 9 23:58:28.311140 systemd[1]: Stopped target local-fs.target - Local File Systems. May 9 23:58:28.313994 systemd[1]: Stopped target swap.target - Swaps. May 9 23:58:28.316433 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 9 23:58:28.316768 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 9 23:58:28.322625 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 9 23:58:28.331782 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 9 23:58:28.335645 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 9 23:58:28.339147 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 9 23:58:28.344199 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 9 23:58:28.344452 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 9 23:58:28.347271 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 9 23:58:28.347508 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 9 23:58:28.350595 systemd[1]: ignition-files.service: Deactivated successfully. May 9 23:58:28.350838 systemd[1]: Stopped ignition-files.service - Ignition (files). May 9 23:58:28.373475 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 9 23:58:28.376283 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 9 23:58:28.376782 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 9 23:58:28.389304 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 9 23:58:28.391422 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 9 23:58:28.392211 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 9 23:58:28.405752 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 9 23:58:28.409076 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 9 23:58:28.428264 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 9 23:58:28.431985 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 9 23:58:28.448128 ignition[1441]: INFO : Ignition 2.19.0 May 9 23:58:28.450831 ignition[1441]: INFO : Stage: umount May 9 23:58:28.452946 ignition[1441]: INFO : no configs at "/usr/lib/ignition/base.d" May 9 23:58:28.457927 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 9 23:58:28.460189 ignition[1441]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" May 9 23:58:28.463707 ignition[1441]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 May 9 23:58:28.467233 ignition[1441]: INFO : PUT result: OK May 9 23:58:28.470761 systemd[1]: sysroot-boot.service: Deactivated successfully. May 9 23:58:28.470998 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 9 23:58:28.478168 ignition[1441]: INFO : umount: umount passed May 9 23:58:28.478168 ignition[1441]: INFO : Ignition finished successfully May 9 23:58:28.482599 systemd[1]: ignition-mount.service: Deactivated successfully. May 9 23:58:28.484135 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 9 23:58:28.489334 systemd[1]: ignition-disks.service: Deactivated successfully. May 9 23:58:28.489441 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 9 23:58:28.493012 systemd[1]: ignition-kargs.service: Deactivated successfully. May 9 23:58:28.493097 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 9 23:58:28.495047 systemd[1]: ignition-fetch.service: Deactivated successfully. May 9 23:58:28.495123 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). May 9 23:58:28.497101 systemd[1]: Stopped target network.target - Network. May 9 23:58:28.498776 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 9 23:58:28.498854 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 9 23:58:28.501153 systemd[1]: Stopped target paths.target - Path Units. May 9 23:58:28.502850 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 9 23:58:28.504085 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 9 23:58:28.504215 systemd[1]: Stopped target slices.target - Slice Units. May 9 23:58:28.504273 systemd[1]: Stopped target sockets.target - Socket Units. May 9 23:58:28.504376 systemd[1]: iscsid.socket: Deactivated successfully. May 9 23:58:28.504468 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 9 23:58:28.504591 systemd[1]: iscsiuio.socket: Deactivated successfully. May 9 23:58:28.504658 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 9 23:58:28.504740 systemd[1]: ignition-setup.service: Deactivated successfully. May 9 23:58:28.504815 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 9 23:58:28.505006 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 9 23:58:28.505085 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 9 23:58:28.544072 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 9 23:58:28.544174 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 9 23:58:28.546510 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 9 23:58:28.548949 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 9 23:58:28.573007 systemd-networkd[1200]: eth0: DHCPv6 lease lost May 9 23:58:28.577928 systemd[1]: systemd-networkd.service: Deactivated successfully. May 9 23:58:28.578364 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 9 23:58:28.603870 systemd[1]: systemd-resolved.service: Deactivated successfully. May 9 23:58:28.605844 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 9 23:58:28.612387 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 9 23:58:28.614282 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 9 23:58:28.627045 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 9 23:58:28.630793 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 9 23:58:28.630984 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 9 23:58:28.634012 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 9 23:58:28.634122 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 9 23:58:28.636993 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 9 23:58:28.637098 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 9 23:58:28.639758 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 9 23:58:28.639875 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 9 23:58:28.646406 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 9 23:58:28.682527 systemd[1]: systemd-udevd.service: Deactivated successfully. May 9 23:58:28.684533 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 9 23:58:28.697277 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 9 23:58:28.697384 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 9 23:58:28.700605 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 9 23:58:28.700709 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 9 23:58:28.703038 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 9 23:58:28.703148 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 9 23:58:28.707214 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 9 23:58:28.707381 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 9 23:58:28.711331 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 9 23:58:28.711425 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 9 23:58:28.731700 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 9 23:58:28.738816 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 9 23:58:28.738986 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 9 23:58:28.741556 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 9 23:58:28.741665 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 9 23:58:28.745858 systemd[1]: network-cleanup.service: Deactivated successfully. May 9 23:58:28.746630 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 9 23:58:28.771361 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 9 23:58:28.771568 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 9 23:58:28.775441 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 9 23:58:28.792434 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 9 23:58:28.812173 systemd[1]: Switching root. May 9 23:58:28.854955 systemd-journald[251]: Journal stopped May 9 23:58:30.587774 systemd-journald[251]: Received SIGTERM from PID 1 (systemd). May 9 23:58:30.587935 kernel: SELinux: policy capability network_peer_controls=1 May 9 23:58:30.587982 kernel: SELinux: policy capability open_perms=1 May 9 23:58:30.588013 kernel: SELinux: policy capability extended_socket_class=1 May 9 23:58:30.588043 kernel: SELinux: policy capability always_check_network=0 May 9 23:58:30.588080 kernel: SELinux: policy capability cgroup_seclabel=1 May 9 23:58:30.588111 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 9 23:58:30.588140 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 9 23:58:30.588172 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 9 23:58:30.588204 kernel: audit: type=1403 audit(1746835109.015:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 9 23:58:30.588237 systemd[1]: Successfully loaded SELinux policy in 49.035ms. May 9 23:58:30.588284 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.188ms. May 9 23:58:30.588321 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) May 9 23:58:30.588357 systemd[1]: Detected virtualization amazon. May 9 23:58:30.588387 systemd[1]: Detected architecture arm64. May 9 23:58:30.588416 systemd[1]: Detected first boot. May 9 23:58:30.588469 systemd[1]: Initializing machine ID from VM UUID. May 9 23:58:30.588504 zram_generator::config[1485]: No configuration found. May 9 23:58:30.588541 systemd[1]: Populated /etc with preset unit settings. May 9 23:58:30.588573 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 9 23:58:30.588602 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 9 23:58:30.588634 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 9 23:58:30.588672 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 9 23:58:30.588704 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 9 23:58:30.588737 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 9 23:58:30.588770 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 9 23:58:30.588800 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 9 23:58:30.588835 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 9 23:58:30.588870 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 9 23:58:30.588917 systemd[1]: Created slice user.slice - User and Session Slice. May 9 23:58:30.588952 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 9 23:58:30.588984 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 9 23:58:30.589014 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 9 23:58:30.589043 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 9 23:58:30.589076 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 9 23:58:30.589110 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 9 23:58:30.589150 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... May 9 23:58:30.589180 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 9 23:58:30.589210 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 9 23:58:30.589241 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 9 23:58:30.589273 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 9 23:58:30.589304 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 9 23:58:30.589345 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 9 23:58:30.589380 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 9 23:58:30.589410 systemd[1]: Reached target slices.target - Slice Units. May 9 23:58:30.589441 systemd[1]: Reached target swap.target - Swaps. May 9 23:58:30.589470 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 9 23:58:30.589502 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 9 23:58:30.589531 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 9 23:58:30.589561 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 9 23:58:30.589592 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 9 23:58:30.589623 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 9 23:58:30.589652 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 9 23:58:30.589696 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 9 23:58:30.589736 systemd[1]: Mounting media.mount - External Media Directory... May 9 23:58:30.589766 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 9 23:58:30.589798 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 9 23:58:30.589830 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 9 23:58:30.589861 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). May 9 23:58:30.589892 systemd[1]: Reached target machines.target - Containers. May 9 23:58:30.604001 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 9 23:58:30.604046 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 9 23:58:30.604081 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 9 23:58:30.604111 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 9 23:58:30.604144 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 9 23:58:30.604174 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 9 23:58:30.604207 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 9 23:58:30.604237 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 9 23:58:30.604266 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 9 23:58:30.604298 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 9 23:58:30.604333 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 9 23:58:30.604365 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 9 23:58:30.604397 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 9 23:58:30.604451 systemd[1]: Stopped systemd-fsck-usr.service. May 9 23:58:30.604487 systemd[1]: Starting systemd-journald.service - Journal Service... May 9 23:58:30.604517 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 9 23:58:30.604546 kernel: fuse: init (API version 7.39) May 9 23:58:30.604576 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 9 23:58:30.604613 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 9 23:58:30.604646 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 9 23:58:30.604679 systemd[1]: verity-setup.service: Deactivated successfully. May 9 23:58:30.604708 systemd[1]: Stopped verity-setup.service. May 9 23:58:30.604737 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 9 23:58:30.604767 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 9 23:58:30.604796 systemd[1]: Mounted media.mount - External Media Directory. May 9 23:58:30.604830 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 9 23:58:30.604859 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 9 23:58:30.604888 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 9 23:58:30.605267 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 9 23:58:30.605303 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 9 23:58:30.605333 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 9 23:58:30.605365 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 9 23:58:30.612021 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 9 23:58:30.612065 kernel: loop: module loaded May 9 23:58:30.612100 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 9 23:58:30.612132 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 9 23:58:30.612163 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 9 23:58:30.612193 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 9 23:58:30.612223 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 9 23:58:30.612253 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 9 23:58:30.612286 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 9 23:58:30.612321 systemd[1]: Reached target network-pre.target - Preparation for Network. May 9 23:58:30.612356 kernel: ACPI: bus type drm_connector registered May 9 23:58:30.612448 systemd-journald[1565]: Collecting audit messages is disabled. May 9 23:58:30.612507 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 9 23:58:30.612544 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 9 23:58:30.612577 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 9 23:58:30.612608 systemd[1]: Reached target local-fs.target - Local File Systems. May 9 23:58:30.612641 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). May 9 23:58:30.612670 systemd-journald[1565]: Journal started May 9 23:58:30.612719 systemd-journald[1565]: Runtime Journal (/run/log/journal/ec2d1ef15685266a3c7a982036f301b9) is 8.0M, max 75.3M, 67.3M free. May 9 23:58:30.003472 systemd[1]: Queued start job for default target multi-user.target. May 9 23:58:30.024265 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. May 9 23:58:30.025103 systemd[1]: systemd-journald.service: Deactivated successfully. May 9 23:58:30.636969 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 9 23:58:30.649087 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 9 23:58:30.649167 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 9 23:58:30.671750 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 9 23:58:30.678058 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 9 23:58:30.686161 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 9 23:58:30.702203 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 9 23:58:30.718959 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 9 23:58:30.732026 systemd[1]: Started systemd-journald.service - Journal Service. May 9 23:58:30.735209 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 9 23:58:30.738178 systemd[1]: modprobe@drm.service: Deactivated successfully. May 9 23:58:30.738456 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 9 23:58:30.741202 systemd[1]: modprobe@loop.service: Deactivated successfully. May 9 23:58:30.741494 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 9 23:58:30.743993 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 9 23:58:30.746645 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 9 23:58:30.750961 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 9 23:58:30.801514 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 9 23:58:30.804104 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 9 23:58:30.811163 kernel: loop0: detected capacity change from 0 to 52536 May 9 23:58:30.816097 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 9 23:58:30.818866 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 9 23:58:30.822343 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 9 23:58:30.839336 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... May 9 23:58:30.867679 systemd-journald[1565]: Time spent on flushing to /var/log/journal/ec2d1ef15685266a3c7a982036f301b9 is 104.498ms for 886 entries. May 9 23:58:30.867679 systemd-journald[1565]: System Journal (/var/log/journal/ec2d1ef15685266a3c7a982036f301b9) is 8.0M, max 195.6M, 187.6M free. May 9 23:58:31.001635 systemd-journald[1565]: Received client request to flush runtime journal. May 9 23:58:31.001740 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 9 23:58:31.001792 kernel: loop1: detected capacity change from 0 to 114432 May 9 23:58:30.883064 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 9 23:58:30.970218 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 9 23:58:30.984881 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... May 9 23:58:31.013038 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 9 23:58:31.018456 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 9 23:58:31.029502 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 9 23:58:31.035844 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 9 23:58:31.040765 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. May 9 23:58:31.055976 kernel: loop2: detected capacity change from 0 to 114328 May 9 23:58:31.058840 udevadm[1629]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. May 9 23:58:31.119083 kernel: loop3: detected capacity change from 0 to 52536 May 9 23:58:31.132245 systemd-tmpfiles[1635]: ACLs are not supported, ignoring. May 9 23:58:31.132285 systemd-tmpfiles[1635]: ACLs are not supported, ignoring. May 9 23:58:31.144141 kernel: loop4: detected capacity change from 0 to 114432 May 9 23:58:31.148146 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 9 23:58:31.176948 kernel: loop5: detected capacity change from 0 to 114328 May 9 23:58:31.200398 (sd-merge)[1639]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. May 9 23:58:31.201788 (sd-merge)[1639]: Merged extensions into '/usr'. May 9 23:58:31.216321 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 9 23:58:31.229491 systemd[1]: Starting ensure-sysext.service... May 9 23:58:31.245224 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 9 23:58:31.267116 systemd[1]: Reloading requested from client PID 1642 ('systemctl') (unit ensure-sysext.service)... May 9 23:58:31.267510 systemd[1]: Reloading... May 9 23:58:31.329868 systemd-tmpfiles[1643]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 9 23:58:31.333856 systemd-tmpfiles[1643]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 9 23:58:31.340794 systemd-tmpfiles[1643]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 9 23:58:31.345565 systemd-tmpfiles[1643]: ACLs are not supported, ignoring. May 9 23:58:31.345728 systemd-tmpfiles[1643]: ACLs are not supported, ignoring. May 9 23:58:31.365576 systemd-tmpfiles[1643]: Detected autofs mount point /boot during canonicalization of boot. May 9 23:58:31.369998 systemd-tmpfiles[1643]: Skipping /boot May 9 23:58:31.439712 systemd-tmpfiles[1643]: Detected autofs mount point /boot during canonicalization of boot. May 9 23:58:31.439741 systemd-tmpfiles[1643]: Skipping /boot May 9 23:58:31.450089 zram_generator::config[1671]: No configuration found. May 9 23:58:31.792705 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. May 9 23:58:31.841588 ldconfig[1589]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 9 23:58:31.924539 systemd[1]: Reloading finished in 656 ms. May 9 23:58:31.980254 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 9 23:58:31.984960 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 9 23:58:32.026350 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... May 9 23:58:32.038211 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 9 23:58:32.053259 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 9 23:58:32.071215 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 9 23:58:32.078149 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 9 23:58:32.093592 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 9 23:58:32.103543 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 9 23:58:32.113719 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 9 23:58:32.120789 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 9 23:58:32.123212 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 9 23:58:32.129774 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 9 23:58:32.130176 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 9 23:58:32.137198 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 9 23:58:32.141005 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 9 23:58:32.143200 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 9 23:58:32.143593 systemd[1]: Reached target time-set.target - System Time Set. May 9 23:58:32.151378 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 9 23:58:32.163628 systemd[1]: Finished ensure-sysext.service. May 9 23:58:32.203112 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 9 23:58:32.203444 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 9 23:58:32.229157 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 9 23:58:32.229468 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 9 23:58:32.237060 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 9 23:58:32.239798 systemd[1]: modprobe@loop.service: Deactivated successfully. May 9 23:58:32.240162 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 9 23:58:32.245054 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 9 23:58:32.249809 systemd[1]: modprobe@drm.service: Deactivated successfully. May 9 23:58:32.250240 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 9 23:58:32.255610 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 9 23:58:32.269169 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 9 23:58:32.320463 augenrules[1758]: No rules May 9 23:58:32.319437 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 9 23:58:32.327619 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. May 9 23:58:32.356461 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 9 23:58:32.359479 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). May 9 23:58:32.444459 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 9 23:58:32.458532 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 9 23:58:32.464267 systemd-resolved[1731]: Positive Trust Anchors: May 9 23:58:32.464299 systemd-resolved[1731]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 9 23:58:32.464363 systemd-resolved[1731]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test May 9 23:58:32.471300 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 9 23:58:32.482711 systemd-resolved[1731]: Defaulting to hostname 'linux'. May 9 23:58:32.487831 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 9 23:58:32.490211 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 9 23:58:32.501021 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 9 23:58:32.534318 systemd-udevd[1771]: Using default interface naming scheme 'v255'. May 9 23:58:32.581527 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 9 23:58:32.593184 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 9 23:58:32.742805 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. May 9 23:58:32.762750 systemd-networkd[1778]: lo: Link UP May 9 23:58:32.762765 systemd-networkd[1778]: lo: Gained carrier May 9 23:58:32.765197 systemd-networkd[1778]: Enumeration completed May 9 23:58:32.765519 systemd[1]: Started systemd-networkd.service - Network Configuration. May 9 23:58:32.767842 systemd[1]: Reached target network.target - Network. May 9 23:58:32.773884 (udev-worker)[1789]: Network interface NamePolicy= disabled on kernel command line. May 9 23:58:32.815408 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 9 23:58:32.884049 systemd-networkd[1778]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 9 23:58:32.884100 systemd-networkd[1778]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 9 23:58:32.887355 systemd-networkd[1778]: eth0: Link UP May 9 23:58:32.889713 systemd-networkd[1778]: eth0: Gained carrier May 9 23:58:32.889752 systemd-networkd[1778]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 9 23:58:32.900052 systemd-networkd[1778]: eth0: DHCPv4 address 172.31.25.130/20, gateway 172.31.16.1 acquired from 172.31.16.1 May 9 23:58:32.930988 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (1775) May 9 23:58:33.041662 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 9 23:58:33.180508 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. May 9 23:58:33.183560 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. May 9 23:58:33.197293 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... May 9 23:58:33.202248 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 9 23:58:33.212021 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 9 23:58:33.228942 lvm[1896]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 9 23:58:33.246022 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 9 23:58:33.274503 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. May 9 23:58:33.277434 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 9 23:58:33.279606 systemd[1]: Reached target sysinit.target - System Initialization. May 9 23:58:33.281844 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 9 23:58:33.284625 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. May 9 23:58:33.287312 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 9 23:58:33.289513 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 9 23:58:33.291912 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 9 23:58:33.294227 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 9 23:58:33.294268 systemd[1]: Reached target paths.target - Path Units. May 9 23:58:33.296000 systemd[1]: Reached target timers.target - Timer Units. May 9 23:58:33.299141 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 9 23:58:33.303761 systemd[1]: Starting docker.socket - Docker Socket for the API... May 9 23:58:33.312073 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 9 23:58:33.316535 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... May 9 23:58:33.319692 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 9 23:58:33.324360 systemd[1]: Reached target sockets.target - Socket Units. May 9 23:58:33.328318 systemd[1]: Reached target basic.target - Basic System. May 9 23:58:33.330694 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 9 23:58:33.330950 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 9 23:58:33.339095 systemd[1]: Starting containerd.service - containerd container runtime... May 9 23:58:33.347071 lvm[1904]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 9 23:58:33.347512 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... May 9 23:58:33.355245 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 9 23:58:33.363762 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 9 23:58:33.371230 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 9 23:58:33.374082 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). May 9 23:58:33.377232 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 9 23:58:33.383414 systemd[1]: Started ntpd.service - Network Time Service. May 9 23:58:33.390119 systemd[1]: Starting setup-oem.service - Setup OEM... May 9 23:58:33.398287 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 9 23:58:33.406339 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 9 23:58:33.418302 systemd[1]: Starting systemd-logind.service - User Login Management... May 9 23:58:33.422429 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 9 23:58:33.424375 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 9 23:58:33.432210 systemd[1]: Starting update-engine.service - Update Engine... May 9 23:58:33.439204 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 9 23:58:33.467992 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. May 9 23:58:33.488780 jq[1908]: false May 9 23:58:33.509493 ntpd[1911]: ntpd 4.2.8p17@1.4004-o Fri May 9 22:02:28 UTC 2025 (1): Starting May 9 23:58:33.510875 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: ntpd 4.2.8p17@1.4004-o Fri May 9 22:02:28 UTC 2025 (1): Starting May 9 23:58:33.511305 ntpd[1911]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp May 9 23:58:33.512726 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp May 9 23:58:33.512726 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: ---------------------------------------------------- May 9 23:58:33.512726 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: ntp-4 is maintained by Network Time Foundation, May 9 23:58:33.512726 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: Inc. (NTF), a non-profit 501(c)(3) public-benefit May 9 23:58:33.512726 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: corporation. Support and training for ntp-4 are May 9 23:58:33.512726 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: available at https://www.nwtime.org/support May 9 23:58:33.512726 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: ---------------------------------------------------- May 9 23:58:33.511337 ntpd[1911]: ---------------------------------------------------- May 9 23:58:33.511357 ntpd[1911]: ntp-4 is maintained by Network Time Foundation, May 9 23:58:33.511376 ntpd[1911]: Inc. (NTF), a non-profit 501(c)(3) public-benefit May 9 23:58:33.511394 ntpd[1911]: corporation. Support and training for ntp-4 are May 9 23:58:33.511411 ntpd[1911]: available at https://www.nwtime.org/support May 9 23:58:33.511430 ntpd[1911]: ---------------------------------------------------- May 9 23:58:33.516414 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 9 23:58:33.516244 ntpd[1911]: proto: precision = 0.108 usec (-23) May 9 23:58:33.516765 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: proto: precision = 0.108 usec (-23) May 9 23:58:33.516793 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 9 23:58:33.519165 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: basedate set to 2025-04-27 May 9 23:58:33.519165 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: gps base set to 2025-04-27 (week 2364) May 9 23:58:33.517384 ntpd[1911]: basedate set to 2025-04-27 May 9 23:58:33.517413 ntpd[1911]: gps base set to 2025-04-27 (week 2364) May 9 23:58:33.523561 ntpd[1911]: Listen and drop on 0 v6wildcard [::]:123 May 9 23:58:33.526075 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: Listen and drop on 0 v6wildcard [::]:123 May 9 23:58:33.526075 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 9 23:58:33.523654 ntpd[1911]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 9 23:58:33.527121 jq[1917]: true May 9 23:58:33.527152 ntpd[1911]: Listen normally on 2 lo 127.0.0.1:123 May 9 23:58:33.527637 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: Listen normally on 2 lo 127.0.0.1:123 May 9 23:58:33.527637 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: Listen normally on 3 eth0 172.31.25.130:123 May 9 23:58:33.527637 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: Listen normally on 4 lo [::1]:123 May 9 23:58:33.527637 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: bind(21) AF_INET6 fe80::4b9:daff:fe08:a527%2#123 flags 0x11 failed: Cannot assign requested address May 9 23:58:33.527637 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: unable to create socket on eth0 (5) for fe80::4b9:daff:fe08:a527%2#123 May 9 23:58:33.527637 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: failed to init interface for address fe80::4b9:daff:fe08:a527%2 May 9 23:58:33.527637 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: Listening on routing socket on fd #21 for interface updates May 9 23:58:33.527223 ntpd[1911]: Listen normally on 3 eth0 172.31.25.130:123 May 9 23:58:33.527297 ntpd[1911]: Listen normally on 4 lo [::1]:123 May 9 23:58:33.527375 ntpd[1911]: bind(21) AF_INET6 fe80::4b9:daff:fe08:a527%2#123 flags 0x11 failed: Cannot assign requested address May 9 23:58:33.527414 ntpd[1911]: unable to create socket on eth0 (5) for fe80::4b9:daff:fe08:a527%2#123 May 9 23:58:33.527441 ntpd[1911]: failed to init interface for address fe80::4b9:daff:fe08:a527%2 May 9 23:58:33.527500 ntpd[1911]: Listening on routing socket on fd #21 for interface updates May 9 23:58:33.546210 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 9 23:58:33.546599 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 9 23:58:33.579939 update_engine[1916]: I20250509 23:58:33.575974 1916 main.cc:92] Flatcar Update Engine starting May 9 23:58:33.584064 ntpd[1911]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 9 23:58:33.586718 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 9 23:58:33.586718 ntpd[1911]: 9 May 23:58:33 ntpd[1911]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 9 23:58:33.584142 ntpd[1911]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 9 23:58:33.606125 dbus-daemon[1907]: [system] SELinux support is enabled May 9 23:58:33.603664 (ntainerd)[1934]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 9 23:58:33.613609 dbus-daemon[1907]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1778 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") May 9 23:58:33.606442 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 9 23:58:33.640665 update_engine[1916]: I20250509 23:58:33.621080 1916 update_check_scheduler.cc:74] Next update check in 4m43s May 9 23:58:33.620580 dbus-daemon[1907]: [system] Successfully activated service 'org.freedesktop.systemd1' May 9 23:58:33.614807 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). May 9 23:58:33.614854 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 9 23:58:33.617368 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). May 9 23:58:33.617402 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 9 23:58:33.621221 systemd[1]: Started update-engine.service - Update Engine. May 9 23:58:33.627307 systemd[1]: motdgen.service: Deactivated successfully. May 9 23:58:33.629058 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 9 23:58:33.660272 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... May 9 23:58:33.675182 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 9 23:58:33.683158 jq[1931]: true May 9 23:58:33.683579 extend-filesystems[1909]: Found loop3 May 9 23:58:33.683579 extend-filesystems[1909]: Found loop4 May 9 23:58:33.683579 extend-filesystems[1909]: Found loop5 May 9 23:58:33.683579 extend-filesystems[1909]: Found nvme0n1 May 9 23:58:33.683579 extend-filesystems[1909]: Found nvme0n1p1 May 9 23:58:33.683579 extend-filesystems[1909]: Found nvme0n1p2 May 9 23:58:33.683579 extend-filesystems[1909]: Found nvme0n1p3 May 9 23:58:33.683579 extend-filesystems[1909]: Found usr May 9 23:58:33.683579 extend-filesystems[1909]: Found nvme0n1p4 May 9 23:58:33.683579 extend-filesystems[1909]: Found nvme0n1p6 May 9 23:58:33.683579 extend-filesystems[1909]: Found nvme0n1p7 May 9 23:58:33.683579 extend-filesystems[1909]: Found nvme0n1p9 May 9 23:58:33.683579 extend-filesystems[1909]: Checking size of /dev/nvme0n1p9 May 9 23:58:33.790106 extend-filesystems[1909]: Resized partition /dev/nvme0n1p9 May 9 23:58:33.802731 extend-filesystems[1958]: resize2fs 1.47.1 (20-May-2024) May 9 23:58:33.815950 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks May 9 23:58:33.827199 systemd[1]: Finished setup-oem.service - Setup OEM. May 9 23:58:33.882472 coreos-metadata[1906]: May 09 23:58:33.882 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 May 9 23:58:33.889055 coreos-metadata[1906]: May 09 23:58:33.888 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 May 9 23:58:33.889055 coreos-metadata[1906]: May 09 23:58:33.888 INFO Fetch successful May 9 23:58:33.889055 coreos-metadata[1906]: May 09 23:58:33.889 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 May 9 23:58:33.889543 coreos-metadata[1906]: May 09 23:58:33.889 INFO Fetch successful May 9 23:58:33.889543 coreos-metadata[1906]: May 09 23:58:33.889 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 May 9 23:58:33.890468 coreos-metadata[1906]: May 09 23:58:33.890 INFO Fetch successful May 9 23:58:33.890730 coreos-metadata[1906]: May 09 23:58:33.890 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 May 9 23:58:33.894193 coreos-metadata[1906]: May 09 23:58:33.894 INFO Fetch successful May 9 23:58:33.894193 coreos-metadata[1906]: May 09 23:58:33.894 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 May 9 23:58:33.898046 coreos-metadata[1906]: May 09 23:58:33.897 INFO Fetch failed with 404: resource not found May 9 23:58:33.898046 coreos-metadata[1906]: May 09 23:58:33.897 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 May 9 23:58:33.898046 coreos-metadata[1906]: May 09 23:58:33.897 INFO Fetch successful May 9 23:58:33.898046 coreos-metadata[1906]: May 09 23:58:33.898 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 May 9 23:58:33.898783 coreos-metadata[1906]: May 09 23:58:33.898 INFO Fetch successful May 9 23:58:33.898783 coreos-metadata[1906]: May 09 23:58:33.898 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 May 9 23:58:33.907049 coreos-metadata[1906]: May 09 23:58:33.906 INFO Fetch successful May 9 23:58:33.907049 coreos-metadata[1906]: May 09 23:58:33.906 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 May 9 23:58:33.907049 coreos-metadata[1906]: May 09 23:58:33.906 INFO Fetch successful May 9 23:58:33.907049 coreos-metadata[1906]: May 09 23:58:33.907 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 May 9 23:58:33.907396 coreos-metadata[1906]: May 09 23:58:33.907 INFO Fetch successful May 9 23:58:33.936978 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 May 9 23:58:33.955118 extend-filesystems[1958]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required May 9 23:58:33.955118 extend-filesystems[1958]: old_desc_blocks = 1, new_desc_blocks = 1 May 9 23:58:33.955118 extend-filesystems[1958]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. May 9 23:58:33.981107 extend-filesystems[1909]: Resized filesystem in /dev/nvme0n1p9 May 9 23:58:33.961737 systemd-logind[1915]: Watching system buttons on /dev/input/event0 (Power Button) May 9 23:58:33.961773 systemd-logind[1915]: Watching system buttons on /dev/input/event1 (Sleep Button) May 9 23:58:33.966572 systemd[1]: extend-filesystems.service: Deactivated successfully. May 9 23:58:33.966949 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 9 23:58:33.971757 systemd-logind[1915]: New seat seat0. May 9 23:58:33.985436 systemd[1]: Started systemd-logind.service - User Login Management. May 9 23:58:34.007479 bash[1985]: Updated "/home/core/.ssh/authorized_keys" May 9 23:58:34.014962 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 9 23:58:34.025309 systemd[1]: Starting sshkeys.service... May 9 23:58:34.041677 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. May 9 23:58:34.045294 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 9 23:58:34.105374 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. May 9 23:58:34.121324 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (1787) May 9 23:58:34.121769 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... May 9 23:58:34.158505 dbus-daemon[1907]: [system] Successfully activated service 'org.freedesktop.hostname1' May 9 23:58:34.161202 systemd[1]: Started systemd-hostnamed.service - Hostname Service. May 9 23:58:34.169147 dbus-daemon[1907]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1944 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") May 9 23:58:34.229526 systemd[1]: Starting polkit.service - Authorization Manager... May 9 23:58:34.261002 polkitd[2021]: Started polkitd version 121 May 9 23:58:34.262154 locksmithd[1947]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 9 23:58:34.274234 polkitd[2021]: Loading rules from directory /etc/polkit-1/rules.d May 9 23:58:34.274343 polkitd[2021]: Loading rules from directory /usr/share/polkit-1/rules.d May 9 23:58:34.279503 polkitd[2021]: Finished loading, compiling and executing 2 rules May 9 23:58:34.281179 dbus-daemon[1907]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' May 9 23:58:34.281673 systemd[1]: Started polkit.service - Authorization Manager. May 9 23:58:34.289289 polkitd[2021]: Acquired the name org.freedesktop.PolicyKit1 on the system bus May 9 23:58:34.355862 systemd-resolved[1731]: System hostname changed to 'ip-172-31-25-130'. May 9 23:58:34.355863 systemd-hostnamed[1944]: Hostname set to (transient) May 9 23:58:34.394043 coreos-metadata[1995]: May 09 23:58:34.393 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 May 9 23:58:34.400740 coreos-metadata[1995]: May 09 23:58:34.396 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 May 9 23:58:34.400740 coreos-metadata[1995]: May 09 23:58:34.400 INFO Fetch successful May 9 23:58:34.400740 coreos-metadata[1995]: May 09 23:58:34.400 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 May 9 23:58:34.404998 coreos-metadata[1995]: May 09 23:58:34.403 INFO Fetch successful May 9 23:58:34.409109 unknown[1995]: wrote ssh authorized keys file for user: core May 9 23:58:34.454583 containerd[1934]: time="2025-05-09T23:58:34.454411651Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 May 9 23:58:34.470822 update-ssh-keys[2090]: Updated "/home/core/.ssh/authorized_keys" May 9 23:58:34.478657 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). May 9 23:58:34.499118 systemd-networkd[1778]: eth0: Gained IPv6LL May 9 23:58:34.501419 systemd[1]: Finished sshkeys.service. May 9 23:58:34.524150 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 9 23:58:34.529656 systemd[1]: Reached target network-online.target - Network is Online. May 9 23:58:34.541371 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. May 9 23:58:34.555417 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 9 23:58:34.667361 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 9 23:58:34.677988 containerd[1934]: time="2025-05-09T23:58:34.676959464Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 May 9 23:58:34.679792 amazon-ssm-agent[2100]: Initializing new seelog logger May 9 23:58:34.680296 amazon-ssm-agent[2100]: New Seelog Logger Creation Complete May 9 23:58:34.680296 amazon-ssm-agent[2100]: 2025/05/09 23:58:34 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. May 9 23:58:34.680296 amazon-ssm-agent[2100]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. May 9 23:58:34.683924 amazon-ssm-agent[2100]: 2025/05/09 23:58:34 processing appconfig overrides May 9 23:58:34.683924 amazon-ssm-agent[2100]: 2025/05/09 23:58:34 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. May 9 23:58:34.683924 amazon-ssm-agent[2100]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. May 9 23:58:34.683924 amazon-ssm-agent[2100]: 2025/05/09 23:58:34 processing appconfig overrides May 9 23:58:34.683924 amazon-ssm-agent[2100]: 2025/05/09 23:58:34 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. May 9 23:58:34.683924 amazon-ssm-agent[2100]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. May 9 23:58:34.683924 amazon-ssm-agent[2100]: 2025/05/09 23:58:34 processing appconfig overrides May 9 23:58:34.683924 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO Proxy environment variables: May 9 23:58:34.684310 containerd[1934]: time="2025-05-09T23:58:34.684167072Z" 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.89-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 May 9 23:58:34.684310 containerd[1934]: time="2025-05-09T23:58:34.684224108Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 May 9 23:58:34.684310 containerd[1934]: time="2025-05-09T23:58:34.684258080Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 May 9 23:58:34.684617 containerd[1934]: time="2025-05-09T23:58:34.684570164Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 May 9 23:58:34.684675 containerd[1934]: time="2025-05-09T23:58:34.684620516Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 May 9 23:58:34.684789 containerd[1934]: time="2025-05-09T23:58:34.684745700Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 May 9 23:58:34.684843 containerd[1934]: time="2025-05-09T23:58:34.684787496Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 May 9 23:58:34.686044 containerd[1934]: time="2025-05-09T23:58:34.685955888Z" 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 May 9 23:58:34.686044 containerd[1934]: time="2025-05-09T23:58:34.686037836Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 May 9 23:58:34.686176 containerd[1934]: time="2025-05-09T23:58:34.686074736Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 May 9 23:58:34.686176 containerd[1934]: time="2025-05-09T23:58:34.686120588Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 May 9 23:58:34.686427 containerd[1934]: time="2025-05-09T23:58:34.686382464Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 May 9 23:58:34.686841 containerd[1934]: time="2025-05-09T23:58:34.686797088Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 May 9 23:58:34.687332 amazon-ssm-agent[2100]: 2025/05/09 23:58:34 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. May 9 23:58:34.687332 amazon-ssm-agent[2100]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. May 9 23:58:34.687460 amazon-ssm-agent[2100]: 2025/05/09 23:58:34 processing appconfig overrides May 9 23:58:34.689029 containerd[1934]: time="2025-05-09T23:58:34.688962224Z" 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 May 9 23:58:34.689029 containerd[1934]: time="2025-05-09T23:58:34.689020724Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 May 9 23:58:34.689321 containerd[1934]: time="2025-05-09T23:58:34.689282576Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 May 9 23:58:34.689434 containerd[1934]: time="2025-05-09T23:58:34.689397536Z" level=info msg="metadata content store policy set" policy=shared May 9 23:58:34.695111 containerd[1934]: time="2025-05-09T23:58:34.695044976Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 May 9 23:58:34.695253 containerd[1934]: time="2025-05-09T23:58:34.695159924Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 May 9 23:58:34.695331 containerd[1934]: time="2025-05-09T23:58:34.695290628Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 May 9 23:58:34.695384 containerd[1934]: time="2025-05-09T23:58:34.695340944Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 May 9 23:58:34.695432 containerd[1934]: time="2025-05-09T23:58:34.695377292Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 May 9 23:58:34.695686 containerd[1934]: time="2025-05-09T23:58:34.695644784Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 May 9 23:58:34.697944 containerd[1934]: time="2025-05-09T23:58:34.696400568Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 May 9 23:58:34.697944 containerd[1934]: time="2025-05-09T23:58:34.696682964Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 May 9 23:58:34.697944 containerd[1934]: time="2025-05-09T23:58:34.696720512Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 May 9 23:58:34.697944 containerd[1934]: time="2025-05-09T23:58:34.696766268Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 May 9 23:58:34.697944 containerd[1934]: time="2025-05-09T23:58:34.696799748Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 May 9 23:58:34.697944 containerd[1934]: time="2025-05-09T23:58:34.696830192Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 May 9 23:58:34.697944 containerd[1934]: time="2025-05-09T23:58:34.696860132Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.696891800Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.698023376Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.698059508Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.698090216Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.698120300Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.698161160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.698194028Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.698230472Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.698262836Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.698291984Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698338 containerd[1934]: time="2025-05-09T23:58:34.698323064Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698352800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698384540Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698417684Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698475980Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698507924Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698536340Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698567120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698601764Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698647412Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698676104Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 May 9 23:58:34.698816 containerd[1934]: time="2025-05-09T23:58:34.698702480Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 May 9 23:58:34.699301 containerd[1934]: time="2025-05-09T23:58:34.698833244Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 May 9 23:58:34.699301 containerd[1934]: time="2025-05-09T23:58:34.699025568Z" 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 May 9 23:58:34.699301 containerd[1934]: time="2025-05-09T23:58:34.699058208Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 May 9 23:58:34.699301 containerd[1934]: time="2025-05-09T23:58:34.699088388Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 May 9 23:58:34.699301 containerd[1934]: time="2025-05-09T23:58:34.699112508Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 May 9 23:58:34.699301 containerd[1934]: time="2025-05-09T23:58:34.699141416Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 May 9 23:58:34.699301 containerd[1934]: time="2025-05-09T23:58:34.699166028Z" level=info msg="NRI interface is disabled by configuration." May 9 23:58:34.699301 containerd[1934]: time="2025-05-09T23:58:34.699191456Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 May 9 23:58:34.701140 containerd[1934]: time="2025-05-09T23:58:34.699715100Z" 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}" May 9 23:58:34.701140 containerd[1934]: time="2025-05-09T23:58:34.699838436Z" level=info msg="Connect containerd service" May 9 23:58:34.701140 containerd[1934]: time="2025-05-09T23:58:34.699890312Z" level=info msg="using legacy CRI server" May 9 23:58:34.701140 containerd[1934]: time="2025-05-09T23:58:34.700940240Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 9 23:58:34.701561 containerd[1934]: time="2025-05-09T23:58:34.701161772Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" May 9 23:58:34.703564 containerd[1934]: time="2025-05-09T23:58:34.702300008Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" May 9 23:58:34.703564 containerd[1934]: time="2025-05-09T23:58:34.703529564Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 9 23:58:34.703712 containerd[1934]: time="2025-05-09T23:58:34.703650344Z" level=info msg=serving... address=/run/containerd/containerd.sock May 9 23:58:34.704834 containerd[1934]: time="2025-05-09T23:58:34.704727152Z" level=info msg="Start subscribing containerd event" May 9 23:58:34.704963 containerd[1934]: time="2025-05-09T23:58:34.704875100Z" level=info msg="Start recovering state" May 9 23:58:34.705089 containerd[1934]: time="2025-05-09T23:58:34.705049808Z" level=info msg="Start event monitor" May 9 23:58:34.705144 containerd[1934]: time="2025-05-09T23:58:34.705088676Z" level=info msg="Start snapshots syncer" May 9 23:58:34.705144 containerd[1934]: time="2025-05-09T23:58:34.705114752Z" level=info msg="Start cni network conf syncer for default" May 9 23:58:34.705235 containerd[1934]: time="2025-05-09T23:58:34.705145364Z" level=info msg="Start streaming server" May 9 23:58:34.709784 containerd[1934]: time="2025-05-09T23:58:34.707458424Z" level=info msg="containerd successfully booted in 0.257747s" May 9 23:58:34.707623 systemd[1]: Started containerd.service - containerd container runtime. May 9 23:58:34.782213 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO https_proxy: May 9 23:58:34.796478 sshd_keygen[1949]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 9 23:58:34.836988 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 9 23:58:34.850075 systemd[1]: Starting issuegen.service - Generate /run/issue... May 9 23:58:34.874631 systemd[1]: issuegen.service: Deactivated successfully. May 9 23:58:34.875273 systemd[1]: Finished issuegen.service - Generate /run/issue. May 9 23:58:34.880178 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO http_proxy: May 9 23:58:34.887049 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 9 23:58:34.915834 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 9 23:58:34.927154 systemd[1]: Started getty@tty1.service - Getty on tty1. May 9 23:58:34.940513 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. May 9 23:58:34.943680 systemd[1]: Reached target getty.target - Login Prompts. May 9 23:58:34.946271 systemd[1]: Reached target multi-user.target - Multi-User System. May 9 23:58:34.949211 systemd[1]: Startup finished in 1.212s (kernel) + 6.216s (initrd) + 5.980s (userspace) = 13.409s. May 9 23:58:34.979155 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO no_proxy: May 9 23:58:35.077615 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO Checking if agent identity type OnPrem can be assumed May 9 23:58:35.175970 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO Checking if agent identity type EC2 can be assumed May 9 23:58:35.275430 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO Agent will take identity from EC2 May 9 23:58:35.374078 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO [amazon-ssm-agent] using named pipe channel for IPC May 9 23:58:35.473512 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO [amazon-ssm-agent] using named pipe channel for IPC May 9 23:58:35.573054 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO [amazon-ssm-agent] using named pipe channel for IPC May 9 23:58:35.672402 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 May 9 23:58:35.759309 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 May 9 23:58:35.760193 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO [amazon-ssm-agent] Starting Core Agent May 9 23:58:35.760193 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO [amazon-ssm-agent] registrar detected. Attempting registration May 9 23:58:35.760193 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO [Registrar] Starting registrar module May 9 23:58:35.760193 amazon-ssm-agent[2100]: 2025-05-09 23:58:34 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration May 9 23:58:35.760193 amazon-ssm-agent[2100]: 2025-05-09 23:58:35 INFO [EC2Identity] EC2 registration was successful. May 9 23:58:35.760193 amazon-ssm-agent[2100]: 2025-05-09 23:58:35 INFO [CredentialRefresher] credentialRefresher has started May 9 23:58:35.760193 amazon-ssm-agent[2100]: 2025-05-09 23:58:35 INFO [CredentialRefresher] Starting credentials refresher loop May 9 23:58:35.760193 amazon-ssm-agent[2100]: 2025-05-09 23:58:35 INFO EC2RoleProvider Successfully connected with instance profile role credentials May 9 23:58:35.772527 amazon-ssm-agent[2100]: 2025-05-09 23:58:35 INFO [CredentialRefresher] Next credential rotation will be in 32.35831363343333 minutes May 9 23:58:36.512088 ntpd[1911]: Listen normally on 6 eth0 [fe80::4b9:daff:fe08:a527%2]:123 May 9 23:58:36.512588 ntpd[1911]: 9 May 23:58:36 ntpd[1911]: Listen normally on 6 eth0 [fe80::4b9:daff:fe08:a527%2]:123 May 9 23:58:36.787288 amazon-ssm-agent[2100]: 2025-05-09 23:58:36 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process May 9 23:58:36.888127 amazon-ssm-agent[2100]: 2025-05-09 23:58:36 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2144) started May 9 23:58:36.988403 amazon-ssm-agent[2100]: 2025-05-09 23:58:36 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds May 9 23:58:37.286007 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 9 23:58:37.292451 systemd[1]: Started sshd@0-172.31.25.130:22-147.75.109.163:45994.service - OpenSSH per-connection server daemon (147.75.109.163:45994). May 9 23:58:37.485285 sshd[2154]: Accepted publickey for core from 147.75.109.163 port 45994 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:37.488813 sshd[2154]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:37.508260 systemd-logind[1915]: New session 1 of user core. May 9 23:58:37.509987 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 9 23:58:37.520379 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 9 23:58:37.544119 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 9 23:58:37.554437 systemd[1]: Starting user@500.service - User Manager for UID 500... May 9 23:58:37.581634 (systemd)[2158]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 9 23:58:37.805356 systemd[2158]: Queued start job for default target default.target. May 9 23:58:37.815983 systemd[2158]: Created slice app.slice - User Application Slice. May 9 23:58:37.816221 systemd[2158]: Reached target paths.target - Paths. May 9 23:58:37.816258 systemd[2158]: Reached target timers.target - Timers. May 9 23:58:37.818778 systemd[2158]: Starting dbus.socket - D-Bus User Message Bus Socket... May 9 23:58:37.847298 systemd[2158]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 9 23:58:37.847529 systemd[2158]: Reached target sockets.target - Sockets. May 9 23:58:37.847561 systemd[2158]: Reached target basic.target - Basic System. May 9 23:58:37.847642 systemd[2158]: Reached target default.target - Main User Target. May 9 23:58:37.847703 systemd[2158]: Startup finished in 254ms. May 9 23:58:37.848766 systemd[1]: Started user@500.service - User Manager for UID 500. May 9 23:58:37.857167 systemd[1]: Started session-1.scope - Session 1 of User core. May 9 23:58:38.017428 systemd[1]: Started sshd@1-172.31.25.130:22-147.75.109.163:45998.service - OpenSSH per-connection server daemon (147.75.109.163:45998). May 9 23:58:38.195638 sshd[2169]: Accepted publickey for core from 147.75.109.163 port 45998 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:38.198266 sshd[2169]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:38.205960 systemd-logind[1915]: New session 2 of user core. May 9 23:58:38.220146 systemd[1]: Started session-2.scope - Session 2 of User core. May 9 23:58:38.347960 sshd[2169]: pam_unix(sshd:session): session closed for user core May 9 23:58:38.354152 systemd[1]: sshd@1-172.31.25.130:22-147.75.109.163:45998.service: Deactivated successfully. May 9 23:58:38.357575 systemd[1]: session-2.scope: Deactivated successfully. May 9 23:58:38.360164 systemd-logind[1915]: Session 2 logged out. Waiting for processes to exit. May 9 23:58:38.362383 systemd-logind[1915]: Removed session 2. May 9 23:58:38.390456 systemd[1]: Started sshd@2-172.31.25.130:22-147.75.109.163:46014.service - OpenSSH per-connection server daemon (147.75.109.163:46014). May 9 23:58:38.564846 sshd[2176]: Accepted publickey for core from 147.75.109.163 port 46014 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:38.568012 sshd[2176]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:38.577564 systemd-logind[1915]: New session 3 of user core. May 9 23:58:38.588243 systemd[1]: Started session-3.scope - Session 3 of User core. May 9 23:58:38.712480 sshd[2176]: pam_unix(sshd:session): session closed for user core May 9 23:58:38.719072 systemd[1]: sshd@2-172.31.25.130:22-147.75.109.163:46014.service: Deactivated successfully. May 9 23:58:38.723472 systemd[1]: session-3.scope: Deactivated successfully. May 9 23:58:38.726619 systemd-logind[1915]: Session 3 logged out. Waiting for processes to exit. May 9 23:58:38.729103 systemd-logind[1915]: Removed session 3. May 9 23:58:38.753472 systemd[1]: Started sshd@3-172.31.25.130:22-147.75.109.163:46022.service - OpenSSH per-connection server daemon (147.75.109.163:46022). May 9 23:58:38.921252 sshd[2183]: Accepted publickey for core from 147.75.109.163 port 46022 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:38.923885 sshd[2183]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:38.931202 systemd-logind[1915]: New session 4 of user core. May 9 23:58:38.943161 systemd[1]: Started session-4.scope - Session 4 of User core. May 9 23:58:39.068999 sshd[2183]: pam_unix(sshd:session): session closed for user core May 9 23:58:39.074194 systemd[1]: sshd@3-172.31.25.130:22-147.75.109.163:46022.service: Deactivated successfully. May 9 23:58:39.078034 systemd[1]: session-4.scope: Deactivated successfully. May 9 23:58:39.080805 systemd-logind[1915]: Session 4 logged out. Waiting for processes to exit. May 9 23:58:39.082757 systemd-logind[1915]: Removed session 4. May 9 23:58:39.119375 systemd[1]: Started sshd@4-172.31.25.130:22-147.75.109.163:46028.service - OpenSSH per-connection server daemon (147.75.109.163:46028). May 9 23:58:39.285704 sshd[2190]: Accepted publickey for core from 147.75.109.163 port 46028 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:39.287798 sshd[2190]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:39.294987 systemd-logind[1915]: New session 5 of user core. May 9 23:58:39.305155 systemd[1]: Started session-5.scope - Session 5 of User core. May 9 23:58:39.422209 sudo[2193]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 9 23:58:39.422836 sudo[2193]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:39.442478 sudo[2193]: pam_unix(sudo:session): session closed for user root May 9 23:58:39.466426 sshd[2190]: pam_unix(sshd:session): session closed for user core May 9 23:58:39.472884 systemd[1]: sshd@4-172.31.25.130:22-147.75.109.163:46028.service: Deactivated successfully. May 9 23:58:39.477623 systemd[1]: session-5.scope: Deactivated successfully. May 9 23:58:39.479228 systemd-logind[1915]: Session 5 logged out. Waiting for processes to exit. May 9 23:58:39.481453 systemd-logind[1915]: Removed session 5. May 9 23:58:39.507439 systemd[1]: Started sshd@5-172.31.25.130:22-147.75.109.163:46042.service - OpenSSH per-connection server daemon (147.75.109.163:46042). May 9 23:58:39.685977 sshd[2198]: Accepted publickey for core from 147.75.109.163 port 46042 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:39.688867 sshd[2198]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:39.697302 systemd-logind[1915]: New session 6 of user core. May 9 23:58:39.705192 systemd[1]: Started session-6.scope - Session 6 of User core. May 9 23:58:39.810472 sudo[2202]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules May 9 23:58:39.811168 sudo[2202]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:39.817412 sudo[2202]: pam_unix(sudo:session): session closed for user root May 9 23:58:39.827561 sudo[2201]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules May 9 23:58:39.828312 sudo[2201]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:39.856132 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... May 9 23:58:39.858288 auditctl[2205]: No rules May 9 23:58:39.859035 systemd[1]: audit-rules.service: Deactivated successfully. May 9 23:58:39.860031 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. May 9 23:58:39.866537 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... May 9 23:58:39.916812 augenrules[2223]: No rules May 9 23:58:39.919483 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. May 9 23:58:39.921861 sudo[2201]: pam_unix(sudo:session): session closed for user root May 9 23:58:39.947243 sshd[2198]: pam_unix(sshd:session): session closed for user core May 9 23:58:39.953106 systemd-logind[1915]: Session 6 logged out. Waiting for processes to exit. May 9 23:58:39.953459 systemd[1]: sshd@5-172.31.25.130:22-147.75.109.163:46042.service: Deactivated successfully. May 9 23:58:39.957308 systemd[1]: session-6.scope: Deactivated successfully. May 9 23:58:39.960890 systemd-logind[1915]: Removed session 6. May 9 23:58:39.979166 systemd[1]: Started sshd@6-172.31.25.130:22-147.75.109.163:46044.service - OpenSSH per-connection server daemon (147.75.109.163:46044). May 9 23:58:40.158486 sshd[2231]: Accepted publickey for core from 147.75.109.163 port 46044 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:40.161042 sshd[2231]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:40.169260 systemd-logind[1915]: New session 7 of user core. May 9 23:58:40.180160 systemd[1]: Started session-7.scope - Session 7 of User core. May 9 23:58:40.284425 sudo[2234]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mkdir -p . May 9 23:58:40.285096 sudo[2234]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:40.291220 sudo[2234]: pam_unix(sudo:session): session closed for user root May 9 23:58:40.314197 sshd[2231]: pam_unix(sshd:session): session closed for user core May 9 23:58:40.321426 systemd[1]: sshd@6-172.31.25.130:22-147.75.109.163:46044.service: Deactivated successfully. May 9 23:58:40.324884 systemd[1]: session-7.scope: Deactivated successfully. May 9 23:58:40.327856 systemd-logind[1915]: Session 7 logged out. Waiting for processes to exit. May 9 23:58:40.329838 systemd-logind[1915]: Removed session 7. May 9 23:58:40.356431 systemd[1]: Started sshd@7-172.31.25.130:22-147.75.109.163:46060.service - OpenSSH per-connection server daemon (147.75.109.163:46060). May 9 23:58:40.522454 sshd[2239]: Accepted publickey for core from 147.75.109.163 port 46060 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:40.525077 sshd[2239]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:40.534852 systemd-logind[1915]: New session 8 of user core. May 9 23:58:40.541217 systemd[1]: Started session-8.scope - Session 8 of User core. May 9 23:58:40.651672 sudo[2242]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/install -m 0755 /dev/stdin kolet May 9 23:58:40.652422 sudo[2242]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:41.393742 sudo[2242]: pam_unix(sudo:session): session closed for user root May 9 23:58:41.416998 sshd[2239]: pam_unix(sshd:session): session closed for user core May 9 23:58:41.423252 systemd[1]: sshd@7-172.31.25.130:22-147.75.109.163:46060.service: Deactivated successfully. May 9 23:58:41.427566 systemd[1]: session-8.scope: Deactivated successfully. May 9 23:58:41.428828 systemd-logind[1915]: Session 8 logged out. Waiting for processes to exit. May 9 23:58:41.430458 systemd-logind[1915]: Removed session 8. May 9 23:58:41.452366 systemd[1]: Started sshd@8-172.31.25.130:22-147.75.109.163:46072.service - OpenSSH per-connection server daemon (147.75.109.163:46072). May 9 23:58:41.631160 sshd[2247]: Accepted publickey for core from 147.75.109.163 port 46072 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:41.633718 sshd[2247]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:41.640869 systemd-logind[1915]: New session 9 of user core. May 9 23:58:41.652154 systemd[1]: Started session-9.scope - Session 9 of User core. May 9 23:58:41.869688 sshd[2247]: pam_unix(sshd:session): session closed for user core May 9 23:58:41.875987 systemd-logind[1915]: Session 9 logged out. Waiting for processes to exit. May 9 23:58:41.877715 systemd[1]: sshd@8-172.31.25.130:22-147.75.109.163:46072.service: Deactivated successfully. May 9 23:58:41.881301 systemd[1]: session-9.scope: Deactivated successfully. May 9 23:58:41.884581 systemd-logind[1915]: Removed session 9. May 9 23:58:41.908096 systemd[1]: Started sshd@9-172.31.25.130:22-147.75.109.163:46086.service - OpenSSH per-connection server daemon (147.75.109.163:46086). May 9 23:58:42.094734 sshd[2266]: Accepted publickey for core from 147.75.109.163 port 46086 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:42.097417 sshd[2266]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:42.106286 systemd-logind[1915]: New session 10 of user core. May 9 23:58:42.114144 systemd[1]: Started session-10.scope - Session 10 of User core. May 9 23:58:42.272203 sshd[2266]: pam_unix(sshd:session): session closed for user core May 9 23:58:42.278353 systemd-logind[1915]: Session 10 logged out. Waiting for processes to exit. May 9 23:58:42.279805 systemd[1]: sshd@9-172.31.25.130:22-147.75.109.163:46086.service: Deactivated successfully. May 9 23:58:42.282683 systemd[1]: session-10.scope: Deactivated successfully. May 9 23:58:42.284317 systemd-logind[1915]: Removed session 10. May 9 23:58:42.315379 systemd[1]: Started sshd@10-172.31.25.130:22-147.75.109.163:46090.service - OpenSSH per-connection server daemon (147.75.109.163:46090). May 9 23:58:42.483580 sshd[2278]: Accepted publickey for core from 147.75.109.163 port 46090 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:42.486169 sshd[2278]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:42.493467 systemd-logind[1915]: New session 11 of user core. May 9 23:58:42.504159 systemd[1]: Started session-11.scope - Session 11 of User core. May 9 23:58:42.663824 sudo[2288]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -o value -s PTUUID /dev/nvme0n1 May 9 23:58:42.665133 sudo[2288]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:42.675162 sudo[2288]: pam_unix(sudo:session): session closed for user root May 9 23:58:42.701125 sshd[2278]: pam_unix(sshd:session): session closed for user core May 9 23:58:42.706065 systemd-logind[1915]: Session 11 logged out. Waiting for processes to exit. May 9 23:58:42.706702 systemd[1]: sshd@10-172.31.25.130:22-147.75.109.163:46090.service: Deactivated successfully. May 9 23:58:42.709349 systemd[1]: session-11.scope: Deactivated successfully. May 9 23:58:42.714416 systemd-logind[1915]: Removed session 11. May 9 23:58:42.743508 systemd[1]: Started sshd@11-172.31.25.130:22-147.75.109.163:46094.service - OpenSSH per-connection server daemon (147.75.109.163:46094). May 9 23:58:42.925362 sshd[2295]: Accepted publickey for core from 147.75.109.163 port 46094 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:42.927856 sshd[2295]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:42.935113 systemd-logind[1915]: New session 12 of user core. May 9 23:58:42.948222 systemd[1]: Started session-12.scope - Session 12 of User core. May 9 23:58:43.091378 sudo[2305]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/useradd -p * -U -m user1 -G sudo May 9 23:58:43.092009 sudo[2305]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:43.121141 useradd[2306]: new group: name=user1, GID=1000 May 9 23:58:43.121170 useradd[2306]: new user: name=user1, UID=1000, GID=1000, home=/home/user1, shell=/bin/bash, from=none May 9 23:58:43.124129 useradd[2306]: add 'user1' to group 'sudo' May 9 23:58:43.124146 useradd[2306]: add 'user1' to shadow group 'sudo' May 9 23:58:43.201437 sudo[2305]: pam_unix(sudo:session): session closed for user root May 9 23:58:43.235076 sshd[2295]: pam_unix(sshd:session): session closed for user core May 9 23:58:43.240995 systemd[1]: sshd@11-172.31.25.130:22-147.75.109.163:46094.service: Deactivated successfully. May 9 23:58:43.244106 systemd[1]: session-12.scope: Deactivated successfully. May 9 23:58:43.246233 systemd-logind[1915]: Session 12 logged out. Waiting for processes to exit. May 9 23:58:43.248486 systemd-logind[1915]: Removed session 12. May 9 23:58:43.273425 systemd[1]: Started sshd@12-172.31.25.130:22-147.75.109.163:46104.service - OpenSSH per-connection server daemon (147.75.109.163:46104). May 9 23:58:43.448656 sshd[2318]: Accepted publickey for core from 147.75.109.163 port 46104 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:43.451199 sshd[2318]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:43.458721 systemd-logind[1915]: New session 13 of user core. May 9 23:58:43.473173 systemd[1]: Started session-13.scope - Session 13 of User core. May 9 23:58:43.627701 sshd[2318]: pam_unix(sshd:session): session closed for user core May 9 23:58:43.632838 systemd-logind[1915]: Session 13 logged out. Waiting for processes to exit. May 9 23:58:43.633892 systemd[1]: sshd@12-172.31.25.130:22-147.75.109.163:46104.service: Deactivated successfully. May 9 23:58:43.637689 systemd[1]: session-13.scope: Deactivated successfully. May 9 23:58:43.641476 systemd-logind[1915]: Removed session 13. May 9 23:58:43.670351 systemd[1]: Started sshd@13-172.31.25.130:22-147.75.109.163:46106.service - OpenSSH per-connection server daemon (147.75.109.163:46106). May 9 23:58:43.837608 sshd[2330]: Accepted publickey for core from 147.75.109.163 port 46106 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:43.840396 sshd[2330]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:43.850084 systemd-logind[1915]: New session 14 of user core. May 9 23:58:43.860254 systemd[1]: Started session-14.scope - Session 14 of User core. May 9 23:58:44.002299 sudo[2339]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/coreos-cloudinit --workspace /tmp/coretest-cloudinit-4103287608 --from-file /tmp/coretest-699342297 --ssh-key-name coretest May 9 23:58:44.003021 sudo[2339]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:44.054424 systemd[1]: Reloading requested from client PID 2340 ('coreos-cloudini') (unit session-14.scope)... May 9 23:58:44.054459 systemd[1]: Reloading... May 9 23:58:44.219015 zram_generator::config[2387]: No configuration found. May 9 23:58:44.438347 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. May 9 23:58:44.608297 systemd[1]: Reloading finished in 553 ms. May 9 23:58:44.652862 sudo[2339]: pam_unix(sudo:session): session closed for user root May 9 23:58:44.676312 sudo[2435]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /tmp/coretest-cloudinit-4103287608 May 9 23:58:44.676993 sudo[2435]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:44.682820 sudo[2435]: pam_unix(sudo:session): session closed for user root May 9 23:58:44.708186 sshd[2330]: pam_unix(sshd:session): session closed for user core May 9 23:58:44.714519 systemd[1]: sshd@13-172.31.25.130:22-147.75.109.163:46106.service: Deactivated successfully. May 9 23:58:44.718529 systemd[1]: session-14.scope: Deactivated successfully. May 9 23:58:44.719951 systemd-logind[1915]: Session 14 logged out. Waiting for processes to exit. May 9 23:58:44.722119 systemd-logind[1915]: Removed session 14. May 9 23:58:44.745428 systemd[1]: Started sshd@14-172.31.25.130:22-147.75.109.163:46116.service - OpenSSH per-connection server daemon (147.75.109.163:46116). May 9 23:58:44.907607 sshd[2440]: Accepted publickey for core from 147.75.109.163 port 46116 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:44.910130 sshd[2440]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:44.918000 systemd-logind[1915]: New session 15 of user core. May 9 23:58:44.927177 systemd[1]: Started session-15.scope - Session 15 of User core. May 9 23:58:45.070369 sudo[2450]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/coreos-cloudinit --workspace /tmp/coretest-cloudinit-1108288203 --from-file /tmp/coretest-1835516488 May 9 23:58:45.071712 sudo[2450]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:45.094422 systemd[1]: Started coreos-cloudinit-3272331366.service - Unit generated and executed by coreos-cloudinit on behalf of user. May 9 23:58:45.098919 sudo[2450]: pam_unix(sudo:session): session closed for user root May 9 23:58:45.151472 sudo[2462]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /tmp/coretest-cloudinit-1108288203 May 9 23:58:45.152554 sudo[2462]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 9 23:58:45.158362 sudo[2462]: pam_unix(sudo:session): session closed for user root May 9 23:58:45.182514 sshd[2440]: pam_unix(sshd:session): session closed for user core May 9 23:58:45.189188 systemd[1]: sshd@14-172.31.25.130:22-147.75.109.163:46116.service: Deactivated successfully. May 9 23:58:45.193517 systemd[1]: session-15.scope: Deactivated successfully. May 9 23:58:45.195010 systemd-logind[1915]: Session 15 logged out. Waiting for processes to exit. May 9 23:58:45.197159 systemd-logind[1915]: Removed session 15. May 9 23:58:45.223404 systemd[1]: Started sshd@15-172.31.25.130:22-147.75.109.163:46122.service - OpenSSH per-connection server daemon (147.75.109.163:46122). May 9 23:58:45.386455 sshd[2467]: Accepted publickey for core from 147.75.109.163 port 46122 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:45.389049 sshd[2467]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:45.398232 systemd-logind[1915]: New session 16 of user core. May 9 23:58:45.404157 systemd[1]: Started session-16.scope - Session 16 of User core. May 9 23:58:45.559413 systemd[1]: Started sshd@16-127.0.0.1:22-127.0.0.1:46272.service - OpenSSH per-connection server daemon (127.0.0.1:46272). May 9 23:58:45.563464 sshd[2467]: pam_unix(sshd:session): session closed for user core May 9 23:58:45.574035 systemd[1]: sshd@15-172.31.25.130:22-147.75.109.163:46122.service: Deactivated successfully. May 9 23:58:45.580433 systemd[1]: session-16.scope: Deactivated successfully. May 9 23:58:45.582185 sshd[2477]: Connection closed by 127.0.0.1 port 46272 May 9 23:58:45.583086 systemd-logind[1915]: Session 16 logged out. Waiting for processes to exit. May 9 23:58:45.583493 systemd[1]: sshd@16-127.0.0.1:22-127.0.0.1:46272.service: Deactivated successfully. May 9 23:58:45.607390 systemd[1]: Started sshd@17-172.31.25.130:22-147.75.109.163:46128.service - OpenSSH per-connection server daemon (147.75.109.163:46128). May 9 23:58:45.610081 systemd-logind[1915]: Removed session 16. May 9 23:58:45.787871 sshd[2483]: Accepted publickey for core from 147.75.109.163 port 46128 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:45.790814 sshd[2483]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:45.802036 systemd-logind[1915]: New session 17 of user core. May 9 23:58:45.808263 systemd[1]: Started session-17.scope - Session 17 of User core. May 9 23:58:45.972078 sshd[2483]: pam_unix(sshd:session): session closed for user core May 9 23:58:45.978550 systemd[1]: sshd@17-172.31.25.130:22-147.75.109.163:46128.service: Deactivated successfully. May 9 23:58:45.982493 systemd[1]: session-17.scope: Deactivated successfully. May 9 23:58:45.985461 systemd-logind[1915]: Session 17 logged out. Waiting for processes to exit. May 9 23:58:45.988046 systemd-logind[1915]: Removed session 17. May 9 23:58:46.016435 systemd[1]: Started sshd@18-172.31.25.130:22-147.75.109.163:46142.service - OpenSSH per-connection server daemon (147.75.109.163:46142). May 9 23:58:46.185285 sshd[2496]: Accepted publickey for core from 147.75.109.163 port 46142 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:46.187418 sshd[2496]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:46.196025 systemd-logind[1915]: New session 18 of user core. May 9 23:58:46.208167 systemd[1]: Started session-18.scope - Session 18 of User core. May 9 23:58:46.354249 sudo[2506]: core : PWD=/home/core ; USER=core ; COMMAND=/usr/bin/gdbus call --system --dest org.freedesktop.systemd1 --object-path /org/freedesktop/systemd1 --method org.freedesktop.systemd1.Manager.RestartUnit ntpd.service replace May 9 23:58:46.354888 sudo[2506]: pam_unix(sudo:session): session opened for user core(uid=500) by core(uid=500) May 9 23:58:46.389628 sudo[2506]: pam_unix(sudo:session): session closed for user core May 9 23:58:46.401082 sudo[2513]: core : PWD=/home/core ; USER=core ; COMMAND=/usr/bin/gdbus call --system --dest org.freedesktop.systemd1 --object-path /org/freedesktop/systemd1/unit/ntpd_2eservice --method org.freedesktop.DBus.Properties.GetAll org.freedesktop.systemd1.Unit May 9 23:58:46.401738 sudo[2513]: pam_unix(sudo:session): session opened for user core(uid=500) by core(uid=500) May 9 23:58:46.427620 sudo[2513]: pam_unix(sudo:session): session closed for user core May 9 23:58:46.452553 sshd[2496]: pam_unix(sshd:session): session closed for user core May 9 23:58:46.459237 systemd[1]: sshd@18-172.31.25.130:22-147.75.109.163:46142.service: Deactivated successfully. May 9 23:58:46.462727 systemd[1]: session-18.scope: Deactivated successfully. May 9 23:58:46.465311 systemd-logind[1915]: Session 18 logged out. Waiting for processes to exit. May 9 23:58:46.467776 systemd-logind[1915]: Removed session 18. May 9 23:58:46.503824 systemd[1]: Started sshd@19-172.31.25.130:22-147.75.109.163:46146.service - OpenSSH per-connection server daemon (147.75.109.163:46146). May 9 23:58:46.668372 sshd[2521]: Accepted publickey for core from 147.75.109.163 port 46146 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:46.670999 sshd[2521]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:46.678413 systemd-logind[1915]: New session 19 of user core. May 9 23:58:46.691133 systemd[1]: Started session-19.scope - Session 19 of User core. May 9 23:58:46.845666 sshd[2521]: pam_unix(sshd:session): session closed for user core May 9 23:58:46.852730 systemd[1]: sshd@19-172.31.25.130:22-147.75.109.163:46146.service: Deactivated successfully. May 9 23:58:46.856107 systemd[1]: session-19.scope: Deactivated successfully. May 9 23:58:46.857532 systemd-logind[1915]: Session 19 logged out. Waiting for processes to exit. May 9 23:58:46.859779 systemd-logind[1915]: Removed session 19. May 9 23:58:46.892384 systemd[1]: Started sshd@20-172.31.25.130:22-147.75.109.163:48134.service - OpenSSH per-connection server daemon (147.75.109.163:48134). May 9 23:58:47.054941 sshd[2532]: Accepted publickey for core from 147.75.109.163 port 48134 ssh2: RSA SHA256:yk6AfQWmMRYxezm8PvpiDSiRPBmf2ReLg5ZxrxD++D8 May 9 23:58:47.057467 sshd[2532]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 9 23:58:47.065297 systemd-logind[1915]: New session 20 of user core. May 9 23:58:47.073154 systemd[1]: Started session-20.scope - Session 20 of User core. May 9 23:58:47.227226 sshd[2532]: pam_unix(sshd:session): session closed for user core May 9 23:58:47.233573 systemd[1]: sshd@20-172.31.25.130:22-147.75.109.163:48134.service: Deactivated successfully. May 9 23:58:47.236522 systemd[1]: session-20.scope: Deactivated successfully. May 9 23:58:47.239080 systemd-logind[1915]: Session 20 logged out. Waiting for processes to exit. May 9 23:58:47.241139 systemd-logind[1915]: Removed session 20.