Jan 29 10:46:11.206898 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Jan 29 10:46:11.206948 kernel: Linux version 6.6.74-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241116 p3) 14.2.1 20241116, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Wed Jan 29 09:30:22 -00 2025 Jan 29 10:46:11.206975 kernel: KASLR disabled due to lack of seed Jan 29 10:46:11.206992 kernel: efi: EFI v2.7 by EDK II Jan 29 10:46:11.207008 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7a736a98 MEMRESERVE=0x78557598 Jan 29 10:46:11.207024 kernel: secureboot: Secure boot disabled Jan 29 10:46:11.207042 kernel: ACPI: Early table checksum verification disabled Jan 29 10:46:11.208269 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Jan 29 10:46:11.208295 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Jan 29 10:46:11.208313 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Jan 29 10:46:11.208341 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Jan 29 10:46:11.208358 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Jan 29 10:46:11.208374 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Jan 29 10:46:11.208390 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Jan 29 10:46:11.208410 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Jan 29 10:46:11.208431 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Jan 29 10:46:11.208449 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Jan 29 10:46:11.208466 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Jan 29 10:46:11.208483 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Jan 29 10:46:11.208500 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Jan 29 10:46:11.208517 kernel: printk: bootconsole [uart0] enabled Jan 29 10:46:11.208534 kernel: NUMA: Failed to initialise from firmware Jan 29 10:46:11.208553 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Jan 29 10:46:11.208570 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Jan 29 10:46:11.208587 kernel: Zone ranges: Jan 29 10:46:11.208604 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Jan 29 10:46:11.208628 kernel: DMA32 empty Jan 29 10:46:11.208645 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Jan 29 10:46:11.208662 kernel: Movable zone start for each node Jan 29 10:46:11.208678 kernel: Early memory node ranges Jan 29 10:46:11.208694 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Jan 29 10:46:11.208711 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Jan 29 10:46:11.208727 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Jan 29 10:46:11.208744 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Jan 29 10:46:11.208760 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Jan 29 10:46:11.208777 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Jan 29 10:46:11.208793 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Jan 29 10:46:11.208810 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Jan 29 10:46:11.208832 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Jan 29 10:46:11.208850 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Jan 29 10:46:11.208874 kernel: psci: probing for conduit method from ACPI. Jan 29 10:46:11.208892 kernel: psci: PSCIv1.0 detected in firmware. Jan 29 10:46:11.208909 kernel: psci: Using standard PSCI v0.2 function IDs Jan 29 10:46:11.208932 kernel: psci: Trusted OS migration not required Jan 29 10:46:11.208950 kernel: psci: SMC Calling Convention v1.1 Jan 29 10:46:11.208967 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Jan 29 10:46:11.208985 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Jan 29 10:46:11.209003 kernel: pcpu-alloc: [0] 0 [0] 1 Jan 29 10:46:11.209020 kernel: Detected PIPT I-cache on CPU0 Jan 29 10:46:11.209039 kernel: CPU features: detected: GIC system register CPU interface Jan 29 10:46:11.210180 kernel: CPU features: detected: Spectre-v2 Jan 29 10:46:11.210210 kernel: CPU features: detected: Spectre-v3a Jan 29 10:46:11.210227 kernel: CPU features: detected: Spectre-BHB Jan 29 10:46:11.210245 kernel: CPU features: detected: ARM erratum 1742098 Jan 29 10:46:11.210262 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Jan 29 10:46:11.210290 kernel: alternatives: applying boot alternatives Jan 29 10:46:11.210310 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=e6957044c3256d96283265c263579aa4275d1d707b02496fcb081f5fc6356346 Jan 29 10:46:11.210329 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jan 29 10:46:11.210347 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 29 10:46:11.210364 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 29 10:46:11.210381 kernel: Fallback order for Node 0: 0 Jan 29 10:46:11.210398 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Jan 29 10:46:11.210415 kernel: Policy zone: Normal Jan 29 10:46:11.210432 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 29 10:46:11.210450 kernel: software IO TLB: area num 2. Jan 29 10:46:11.210472 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Jan 29 10:46:11.210490 kernel: Memory: 3819640K/4030464K available (10304K kernel code, 2186K rwdata, 8092K rodata, 39936K init, 897K bss, 210824K reserved, 0K cma-reserved) Jan 29 10:46:11.210507 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jan 29 10:46:11.210524 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 29 10:46:11.210542 kernel: rcu: RCU event tracing is enabled. Jan 29 10:46:11.210559 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jan 29 10:46:11.210577 kernel: Trampoline variant of Tasks RCU enabled. Jan 29 10:46:11.210594 kernel: Tracing variant of Tasks RCU enabled. Jan 29 10:46:11.210611 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 29 10:46:11.210628 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jan 29 10:46:11.210645 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 29 10:46:11.210667 kernel: GICv3: 96 SPIs implemented Jan 29 10:46:11.210684 kernel: GICv3: 0 Extended SPIs implemented Jan 29 10:46:11.210701 kernel: Root IRQ handler: gic_handle_irq Jan 29 10:46:11.210718 kernel: GICv3: GICv3 features: 16 PPIs Jan 29 10:46:11.210735 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Jan 29 10:46:11.210751 kernel: ITS [mem 0x10080000-0x1009ffff] Jan 29 10:46:11.210768 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Jan 29 10:46:11.210786 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Jan 29 10:46:11.210803 kernel: GICv3: using LPI property table @0x00000004000d0000 Jan 29 10:46:11.210820 kernel: ITS: Using hypervisor restricted LPI range [128] Jan 29 10:46:11.210838 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Jan 29 10:46:11.210855 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 29 10:46:11.210876 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Jan 29 10:46:11.210894 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Jan 29 10:46:11.210911 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Jan 29 10:46:11.210928 kernel: Console: colour dummy device 80x25 Jan 29 10:46:11.210946 kernel: printk: console [tty1] enabled Jan 29 10:46:11.210964 kernel: ACPI: Core revision 20230628 Jan 29 10:46:11.210982 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Jan 29 10:46:11.211000 kernel: pid_max: default: 32768 minimum: 301 Jan 29 10:46:11.211017 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 29 10:46:11.211034 kernel: landlock: Up and running. Jan 29 10:46:11.211084 kernel: SELinux: Initializing. Jan 29 10:46:11.211133 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 10:46:11.211152 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 10:46:11.211171 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 29 10:46:11.211190 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 29 10:46:11.211209 kernel: rcu: Hierarchical SRCU implementation. Jan 29 10:46:11.211228 kernel: rcu: Max phase no-delay instances is 400. Jan 29 10:46:11.211246 kernel: Platform MSI: ITS@0x10080000 domain created Jan 29 10:46:11.211274 kernel: PCI/MSI: ITS@0x10080000 domain created Jan 29 10:46:11.211292 kernel: Remapping and enabling EFI services. Jan 29 10:46:11.211310 kernel: smp: Bringing up secondary CPUs ... Jan 29 10:46:11.211327 kernel: Detected PIPT I-cache on CPU1 Jan 29 10:46:11.211345 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Jan 29 10:46:11.211363 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Jan 29 10:46:11.211381 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Jan 29 10:46:11.211398 kernel: smp: Brought up 1 node, 2 CPUs Jan 29 10:46:11.211416 kernel: SMP: Total of 2 processors activated. Jan 29 10:46:11.211434 kernel: CPU features: detected: 32-bit EL0 Support Jan 29 10:46:11.211459 kernel: CPU features: detected: 32-bit EL1 Support Jan 29 10:46:11.211476 kernel: CPU features: detected: CRC32 instructions Jan 29 10:46:11.211508 kernel: CPU: All CPU(s) started at EL1 Jan 29 10:46:11.211533 kernel: alternatives: applying system-wide alternatives Jan 29 10:46:11.211552 kernel: devtmpfs: initialized Jan 29 10:46:11.211572 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 29 10:46:11.211592 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jan 29 10:46:11.211612 kernel: pinctrl core: initialized pinctrl subsystem Jan 29 10:46:11.211632 kernel: SMBIOS 3.0.0 present. Jan 29 10:46:11.211661 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Jan 29 10:46:11.211680 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 29 10:46:11.211700 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 29 10:46:11.211720 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 29 10:46:11.211739 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 29 10:46:11.211759 kernel: audit: initializing netlink subsys (disabled) Jan 29 10:46:11.211778 kernel: audit: type=2000 audit(0.273:1): state=initialized audit_enabled=0 res=1 Jan 29 10:46:11.211806 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 29 10:46:11.211827 kernel: cpuidle: using governor menu Jan 29 10:46:11.211847 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 29 10:46:11.211867 kernel: ASID allocator initialised with 65536 entries Jan 29 10:46:11.211886 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 29 10:46:11.211905 kernel: Serial: AMBA PL011 UART driver Jan 29 10:46:11.211924 kernel: Modules: 17360 pages in range for non-PLT usage Jan 29 10:46:11.211943 kernel: Modules: 508880 pages in range for PLT usage Jan 29 10:46:11.211962 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 29 10:46:11.211988 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 29 10:46:11.212007 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 29 10:46:11.212026 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 29 10:46:11.214085 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 29 10:46:11.214150 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 29 10:46:11.214170 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 29 10:46:11.214189 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 29 10:46:11.214207 kernel: ACPI: Added _OSI(Module Device) Jan 29 10:46:11.214226 kernel: ACPI: Added _OSI(Processor Device) Jan 29 10:46:11.214257 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jan 29 10:46:11.214276 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 29 10:46:11.214294 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 29 10:46:11.214312 kernel: ACPI: Interpreter enabled Jan 29 10:46:11.214330 kernel: ACPI: Using GIC for interrupt routing Jan 29 10:46:11.214348 kernel: ACPI: MCFG table detected, 1 entries Jan 29 10:46:11.214367 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Jan 29 10:46:11.214784 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jan 29 10:46:11.215140 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jan 29 10:46:11.215420 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jan 29 10:46:11.215663 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Jan 29 10:46:11.215885 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Jan 29 10:46:11.215913 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Jan 29 10:46:11.215932 kernel: acpiphp: Slot [1] registered Jan 29 10:46:11.215952 kernel: acpiphp: Slot [2] registered Jan 29 10:46:11.215970 kernel: acpiphp: Slot [3] registered Jan 29 10:46:11.216001 kernel: acpiphp: Slot [4] registered Jan 29 10:46:11.216020 kernel: acpiphp: Slot [5] registered Jan 29 10:46:11.216038 kernel: acpiphp: Slot [6] registered Jan 29 10:46:11.216107 kernel: acpiphp: Slot [7] registered Jan 29 10:46:11.216128 kernel: acpiphp: Slot [8] registered Jan 29 10:46:11.216147 kernel: acpiphp: Slot [9] registered Jan 29 10:46:11.216166 kernel: acpiphp: Slot [10] registered Jan 29 10:46:11.216185 kernel: acpiphp: Slot [11] registered Jan 29 10:46:11.216202 kernel: acpiphp: Slot [12] registered Jan 29 10:46:11.216221 kernel: acpiphp: Slot [13] registered Jan 29 10:46:11.216246 kernel: acpiphp: Slot [14] registered Jan 29 10:46:11.216264 kernel: acpiphp: Slot [15] registered Jan 29 10:46:11.216282 kernel: acpiphp: Slot [16] registered Jan 29 10:46:11.216300 kernel: acpiphp: Slot [17] registered Jan 29 10:46:11.216318 kernel: acpiphp: Slot [18] registered Jan 29 10:46:11.216336 kernel: acpiphp: Slot [19] registered Jan 29 10:46:11.216353 kernel: acpiphp: Slot [20] registered Jan 29 10:46:11.216372 kernel: acpiphp: Slot [21] registered Jan 29 10:46:11.216390 kernel: acpiphp: Slot [22] registered Jan 29 10:46:11.216414 kernel: acpiphp: Slot [23] registered Jan 29 10:46:11.216433 kernel: acpiphp: Slot [24] registered Jan 29 10:46:11.216452 kernel: acpiphp: Slot [25] registered Jan 29 10:46:11.216470 kernel: acpiphp: Slot [26] registered Jan 29 10:46:11.216489 kernel: acpiphp: Slot [27] registered Jan 29 10:46:11.216507 kernel: acpiphp: Slot [28] registered Jan 29 10:46:11.216525 kernel: acpiphp: Slot [29] registered Jan 29 10:46:11.216544 kernel: acpiphp: Slot [30] registered Jan 29 10:46:11.216563 kernel: acpiphp: Slot [31] registered Jan 29 10:46:11.216581 kernel: PCI host bridge to bus 0000:00 Jan 29 10:46:11.216883 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Jan 29 10:46:11.217177 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jan 29 10:46:11.217419 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Jan 29 10:46:11.217629 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Jan 29 10:46:11.217876 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Jan 29 10:46:11.219306 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Jan 29 10:46:11.219614 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Jan 29 10:46:11.219889 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Jan 29 10:46:11.220223 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Jan 29 10:46:11.220475 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Jan 29 10:46:11.220719 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Jan 29 10:46:11.220949 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Jan 29 10:46:11.224764 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Jan 29 10:46:11.225148 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Jan 29 10:46:11.225425 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Jan 29 10:46:11.225664 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Jan 29 10:46:11.225880 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Jan 29 10:46:11.227245 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Jan 29 10:46:11.227515 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Jan 29 10:46:11.227748 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Jan 29 10:46:11.227962 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Jan 29 10:46:11.228216 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jan 29 10:46:11.228457 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Jan 29 10:46:11.228493 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jan 29 10:46:11.228514 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jan 29 10:46:11.228533 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jan 29 10:46:11.228553 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jan 29 10:46:11.228572 kernel: iommu: Default domain type: Translated Jan 29 10:46:11.228605 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 29 10:46:11.228624 kernel: efivars: Registered efivars operations Jan 29 10:46:11.228643 kernel: vgaarb: loaded Jan 29 10:46:11.228662 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 29 10:46:11.228680 kernel: VFS: Disk quotas dquot_6.6.0 Jan 29 10:46:11.228700 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 29 10:46:11.228719 kernel: pnp: PnP ACPI init Jan 29 10:46:11.228971 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Jan 29 10:46:11.229009 kernel: pnp: PnP ACPI: found 1 devices Jan 29 10:46:11.229029 kernel: NET: Registered PF_INET protocol family Jan 29 10:46:11.229656 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 29 10:46:11.229711 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 29 10:46:11.229732 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 29 10:46:11.229752 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 29 10:46:11.229775 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 29 10:46:11.229797 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 29 10:46:11.229816 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 10:46:11.229850 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 10:46:11.229869 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 29 10:46:11.229889 kernel: PCI: CLS 0 bytes, default 64 Jan 29 10:46:11.229910 kernel: kvm [1]: HYP mode not available Jan 29 10:46:11.229930 kernel: Initialise system trusted keyrings Jan 29 10:46:11.229950 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 29 10:46:11.229969 kernel: Key type asymmetric registered Jan 29 10:46:11.229988 kernel: Asymmetric key parser 'x509' registered Jan 29 10:46:11.230007 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jan 29 10:46:11.230031 kernel: io scheduler mq-deadline registered Jan 29 10:46:11.230103 kernel: io scheduler kyber registered Jan 29 10:46:11.230126 kernel: io scheduler bfq registered Jan 29 10:46:11.230426 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Jan 29 10:46:11.230459 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jan 29 10:46:11.230478 kernel: ACPI: button: Power Button [PWRB] Jan 29 10:46:11.230497 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Jan 29 10:46:11.230515 kernel: ACPI: button: Sleep Button [SLPB] Jan 29 10:46:11.230546 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 29 10:46:11.230567 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Jan 29 10:46:11.230799 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Jan 29 10:46:11.230828 kernel: printk: console [ttyS0] disabled Jan 29 10:46:11.230847 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Jan 29 10:46:11.230866 kernel: printk: console [ttyS0] enabled Jan 29 10:46:11.230884 kernel: printk: bootconsole [uart0] disabled Jan 29 10:46:11.230902 kernel: thunder_xcv, ver 1.0 Jan 29 10:46:11.230921 kernel: thunder_bgx, ver 1.0 Jan 29 10:46:11.230940 kernel: nicpf, ver 1.0 Jan 29 10:46:11.230967 kernel: nicvf, ver 1.0 Jan 29 10:46:11.231277 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 29 10:46:11.231512 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-01-29T10:46:10 UTC (1738147570) Jan 29 10:46:11.231549 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 29 10:46:11.231571 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Jan 29 10:46:11.231591 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jan 29 10:46:11.231610 kernel: watchdog: Hard watchdog permanently disabled Jan 29 10:46:11.231642 kernel: NET: Registered PF_INET6 protocol family Jan 29 10:46:11.231661 kernel: Segment Routing with IPv6 Jan 29 10:46:11.231679 kernel: In-situ OAM (IOAM) with IPv6 Jan 29 10:46:11.231698 kernel: NET: Registered PF_PACKET protocol family Jan 29 10:46:11.231717 kernel: Key type dns_resolver registered Jan 29 10:46:11.231736 kernel: registered taskstats version 1 Jan 29 10:46:11.231754 kernel: Loading compiled-in X.509 certificates Jan 29 10:46:11.231773 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.74-flatcar: c31663d2c680b3b306c17f44b5295280d3a2e28a' Jan 29 10:46:11.231793 kernel: Key type .fscrypt registered Jan 29 10:46:11.231822 kernel: Key type fscrypt-provisioning registered Jan 29 10:46:11.231851 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 29 10:46:11.231872 kernel: ima: Allocated hash algorithm: sha1 Jan 29 10:46:11.231890 kernel: ima: No architecture policies found Jan 29 10:46:11.231912 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 29 10:46:11.231932 kernel: clk: Disabling unused clocks Jan 29 10:46:11.231954 kernel: Freeing unused kernel memory: 39936K Jan 29 10:46:11.231972 kernel: Run /init as init process Jan 29 10:46:11.231990 kernel: with arguments: Jan 29 10:46:11.232009 kernel: /init Jan 29 10:46:11.232032 kernel: with environment: Jan 29 10:46:11.232224 kernel: HOME=/ Jan 29 10:46:11.232255 kernel: TERM=linux Jan 29 10:46:11.232275 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jan 29 10:46:11.232305 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) Jan 29 10:46:11.232330 systemd[1]: Detected virtualization amazon. Jan 29 10:46:11.232351 systemd[1]: Detected architecture arm64. Jan 29 10:46:11.232384 systemd[1]: Running in initrd. Jan 29 10:46:11.232404 systemd[1]: No hostname configured, using default hostname. Jan 29 10:46:11.232424 systemd[1]: Hostname set to . Jan 29 10:46:11.232445 systemd[1]: Initializing machine ID from VM UUID. Jan 29 10:46:11.232465 systemd[1]: Queued start job for default target initrd.target. Jan 29 10:46:11.232485 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 10:46:11.232506 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 10:46:11.232527 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 29 10:46:11.232559 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 10:46:11.232580 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 29 10:46:11.232601 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 29 10:46:11.232625 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 29 10:46:11.232646 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 29 10:46:11.232667 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 10:46:11.232688 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 10:46:11.232717 systemd[1]: Reached target paths.target - Path Units. Jan 29 10:46:11.232738 systemd[1]: Reached target slices.target - Slice Units. Jan 29 10:46:11.232758 systemd[1]: Reached target swap.target - Swaps. Jan 29 10:46:11.232783 systemd[1]: Reached target timers.target - Timer Units. Jan 29 10:46:11.232834 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 10:46:11.232899 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 10:46:11.232947 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 29 10:46:11.232972 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 29 10:46:11.232998 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 10:46:11.233036 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 10:46:11.233155 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 10:46:11.233180 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 10:46:11.233201 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 29 10:46:11.233221 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 10:46:11.233241 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 29 10:46:11.233261 systemd[1]: Starting systemd-fsck-usr.service... Jan 29 10:46:11.233282 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 10:46:11.233314 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 10:46:11.233336 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 10:46:11.233356 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 29 10:46:11.233377 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 10:46:11.233397 systemd[1]: Finished systemd-fsck-usr.service. Jan 29 10:46:11.233486 systemd-journald[251]: Collecting audit messages is disabled. Jan 29 10:46:11.233542 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 29 10:46:11.233562 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jan 29 10:46:11.233583 systemd-journald[251]: Journal started Jan 29 10:46:11.233637 systemd-journald[251]: Runtime Journal (/run/log/journal/ec2e1ec7d9f68efef88be29f485c952c) is 8.0M, max 75.3M, 67.3M free. Jan 29 10:46:11.239117 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 10:46:11.194499 systemd-modules-load[252]: Inserted module 'overlay' Jan 29 10:46:11.250746 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 10:46:11.250832 kernel: Bridge firewalling registered Jan 29 10:46:11.247975 systemd-modules-load[252]: Inserted module 'br_netfilter' Jan 29 10:46:11.254496 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 10:46:11.269335 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 10:46:11.282346 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 10:46:11.293338 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 10:46:11.304463 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 10:46:11.318433 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 10:46:11.336018 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 10:46:11.351628 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 10:46:11.370445 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 29 10:46:11.375001 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 10:46:11.381511 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 10:46:11.395400 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 10:46:11.410299 dracut-cmdline[286]: dracut-dracut-053 Jan 29 10:46:11.420302 dracut-cmdline[286]: 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=e6957044c3256d96283265c263579aa4275d1d707b02496fcb081f5fc6356346 Jan 29 10:46:11.475227 systemd-resolved[291]: Positive Trust Anchors: Jan 29 10:46:11.475256 systemd-resolved[291]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 10:46:11.475316 systemd-resolved[291]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 29 10:46:11.582096 kernel: SCSI subsystem initialized Jan 29 10:46:11.591084 kernel: Loading iSCSI transport class v2.0-870. Jan 29 10:46:11.603094 kernel: iscsi: registered transport (tcp) Jan 29 10:46:11.625212 kernel: iscsi: registered transport (qla4xxx) Jan 29 10:46:11.625290 kernel: QLogic iSCSI HBA Driver Jan 29 10:46:11.711083 kernel: random: crng init done Jan 29 10:46:11.711416 systemd-resolved[291]: Defaulting to hostname 'linux'. Jan 29 10:46:11.714861 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 10:46:11.719680 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 10:46:11.744119 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 29 10:46:11.753416 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 29 10:46:11.796282 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 29 10:46:11.796359 kernel: device-mapper: uevent: version 1.0.3 Jan 29 10:46:11.798333 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 29 10:46:11.865138 kernel: raid6: neonx8 gen() 6437 MB/s Jan 29 10:46:11.882103 kernel: raid6: neonx4 gen() 6423 MB/s Jan 29 10:46:11.899090 kernel: raid6: neonx2 gen() 5354 MB/s Jan 29 10:46:11.916088 kernel: raid6: neonx1 gen() 3924 MB/s Jan 29 10:46:11.933093 kernel: raid6: int64x8 gen() 3600 MB/s Jan 29 10:46:11.950084 kernel: raid6: int64x4 gen() 3681 MB/s Jan 29 10:46:11.967082 kernel: raid6: int64x2 gen() 3553 MB/s Jan 29 10:46:11.984858 kernel: raid6: int64x1 gen() 2758 MB/s Jan 29 10:46:11.984891 kernel: raid6: using algorithm neonx8 gen() 6437 MB/s Jan 29 10:46:12.002857 kernel: raid6: .... xor() 4795 MB/s, rmw enabled Jan 29 10:46:12.002906 kernel: raid6: using neon recovery algorithm Jan 29 10:46:12.010091 kernel: xor: measuring software checksum speed Jan 29 10:46:12.011086 kernel: 8regs : 11876 MB/sec Jan 29 10:46:12.013292 kernel: 32regs : 11880 MB/sec Jan 29 10:46:12.013324 kernel: arm64_neon : 9509 MB/sec Jan 29 10:46:12.013349 kernel: xor: using function: 32regs (11880 MB/sec) Jan 29 10:46:12.097116 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 29 10:46:12.117339 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 29 10:46:12.127446 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 10:46:12.172287 systemd-udevd[471]: Using default interface naming scheme 'v255'. Jan 29 10:46:12.181893 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 10:46:12.191316 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 29 10:46:12.231677 dracut-pre-trigger[476]: rd.md=0: removing MD RAID activation Jan 29 10:46:12.294542 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 10:46:12.304387 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 10:46:12.436257 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 10:46:12.449401 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 29 10:46:12.500988 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 29 10:46:12.507285 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 10:46:12.507539 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 10:46:12.537288 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 10:46:12.550359 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 29 10:46:12.597026 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 29 10:46:12.652123 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jan 29 10:46:12.652193 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Jan 29 10:46:12.689524 kernel: ena 0000:00:05.0: ENA device version: 0.10 Jan 29 10:46:12.689828 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Jan 29 10:46:12.690128 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:89:ed:e3:06:d9 Jan 29 10:46:12.690378 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Jan 29 10:46:12.690409 kernel: nvme nvme0: pci function 0000:00:04.0 Jan 29 10:46:12.699471 kernel: nvme nvme0: 2/0/0 default/read/poll queues Jan 29 10:46:12.697861 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 10:46:12.698393 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 10:46:12.702877 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 10:46:12.707375 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 10:46:12.707896 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 10:46:12.714476 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 10:46:12.734236 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jan 29 10:46:12.734317 kernel: GPT:9289727 != 16777215 Jan 29 10:46:12.734343 kernel: GPT:Alternate GPT header not at the end of the disk. Jan 29 10:46:12.736149 kernel: GPT:9289727 != 16777215 Jan 29 10:46:12.737723 kernel: GPT: Use GNU Parted to correct GPT errors. Jan 29 10:46:12.737785 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jan 29 10:46:12.737684 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 10:46:12.749746 (udev-worker)[515]: Network interface NamePolicy= disabled on kernel command line. Jan 29 10:46:12.772068 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 10:46:12.791300 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 10:46:12.833477 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 10:46:12.874224 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by (udev-worker) (522) Jan 29 10:46:12.890105 kernel: BTRFS: device fsid 1e2e5fa7-c757-4d5d-af66-73afe98fbaae devid 1 transid 39 /dev/nvme0n1p3 scanned by (udev-worker) (536) Jan 29 10:46:12.996851 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Jan 29 10:46:13.017291 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Jan 29 10:46:13.036128 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Jan 29 10:46:13.052603 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Jan 29 10:46:13.057612 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Jan 29 10:46:13.068355 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 29 10:46:13.090759 disk-uuid[661]: Primary Header is updated. Jan 29 10:46:13.090759 disk-uuid[661]: Secondary Entries is updated. Jan 29 10:46:13.090759 disk-uuid[661]: Secondary Header is updated. Jan 29 10:46:13.102113 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jan 29 10:46:14.124499 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jan 29 10:46:14.126106 disk-uuid[662]: The operation has completed successfully. Jan 29 10:46:14.330795 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 29 10:46:14.331024 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 29 10:46:14.391348 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 29 10:46:14.400365 sh[923]: Success Jan 29 10:46:14.419086 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jan 29 10:46:14.507600 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 29 10:46:14.522561 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 29 10:46:14.529708 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 29 10:46:14.575916 kernel: BTRFS info (device dm-0): first mount of filesystem 1e2e5fa7-c757-4d5d-af66-73afe98fbaae Jan 29 10:46:14.575995 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 29 10:46:14.576035 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 29 10:46:14.579150 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 29 10:46:14.579225 kernel: BTRFS info (device dm-0): using free space tree Jan 29 10:46:14.690098 kernel: BTRFS info (device dm-0): enabling ssd optimizations Jan 29 10:46:14.723810 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 29 10:46:14.726645 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 29 10:46:14.736433 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 29 10:46:14.742729 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 29 10:46:14.775123 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 29 10:46:14.775201 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jan 29 10:46:14.776501 kernel: BTRFS info (device nvme0n1p6): using free space tree Jan 29 10:46:14.784241 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jan 29 10:46:14.801820 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 29 10:46:14.805273 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 29 10:46:14.815770 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 29 10:46:14.828430 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 29 10:46:14.954535 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 29 10:46:14.965381 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 10:46:15.024446 systemd-networkd[1116]: lo: Link UP Jan 29 10:46:15.024464 systemd-networkd[1116]: lo: Gained carrier Jan 29 10:46:15.028541 systemd-networkd[1116]: Enumeration completed Jan 29 10:46:15.029307 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 10:46:15.031838 systemd-networkd[1116]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 10:46:15.031845 systemd-networkd[1116]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 10:46:15.034276 systemd[1]: Reached target network.target - Network. Jan 29 10:46:15.046515 systemd-networkd[1116]: eth0: Link UP Jan 29 10:46:15.046523 systemd-networkd[1116]: eth0: Gained carrier Jan 29 10:46:15.046541 systemd-networkd[1116]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 10:46:15.064187 systemd-networkd[1116]: eth0: DHCPv4 address 172.31.25.38/20, gateway 172.31.16.1 acquired from 172.31.16.1 Jan 29 10:46:15.191576 ignition[1032]: Ignition 2.20.0 Jan 29 10:46:15.191597 ignition[1032]: Stage: fetch-offline Jan 29 10:46:15.192012 ignition[1032]: no configs at "/usr/lib/ignition/base.d" Jan 29 10:46:15.195719 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 29 10:46:15.192035 ignition[1032]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:46:15.192943 ignition[1032]: Ignition finished successfully Jan 29 10:46:15.207347 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jan 29 10:46:15.241597 ignition[1126]: Ignition 2.20.0 Jan 29 10:46:15.241623 ignition[1126]: Stage: fetch Jan 29 10:46:15.243236 ignition[1126]: no configs at "/usr/lib/ignition/base.d" Jan 29 10:46:15.243264 ignition[1126]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:46:15.244038 ignition[1126]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:46:15.254754 ignition[1126]: PUT result: OK Jan 29 10:46:15.257432 ignition[1126]: parsed url from cmdline: "" Jan 29 10:46:15.257454 ignition[1126]: no config URL provided Jan 29 10:46:15.257470 ignition[1126]: reading system config file "/usr/lib/ignition/user.ign" Jan 29 10:46:15.257523 ignition[1126]: no config at "/usr/lib/ignition/user.ign" Jan 29 10:46:15.257558 ignition[1126]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:46:15.261317 ignition[1126]: PUT result: OK Jan 29 10:46:15.261413 ignition[1126]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Jan 29 10:46:15.266785 ignition[1126]: GET result: OK Jan 29 10:46:15.266921 ignition[1126]: parsing config with SHA512: 8c375dc6199e70618cf707e3fef04048f500cfdd44a139835e0b6fc2457550ce2b9c1303c0dcf58a50c9dcecdd3db49bcf915ae6d90e4557f9a76a57085de5de Jan 29 10:46:15.279828 unknown[1126]: fetched base config from "system" Jan 29 10:46:15.280121 unknown[1126]: fetched base config from "system" Jan 29 10:46:15.280464 ignition[1126]: fetch: fetch complete Jan 29 10:46:15.280135 unknown[1126]: fetched user config from "aws" Jan 29 10:46:15.280476 ignition[1126]: fetch: fetch passed Jan 29 10:46:15.280557 ignition[1126]: Ignition finished successfully Jan 29 10:46:15.291702 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jan 29 10:46:15.311543 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 29 10:46:15.336330 ignition[1133]: Ignition 2.20.0 Jan 29 10:46:15.336863 ignition[1133]: Stage: kargs Jan 29 10:46:15.337575 ignition[1133]: no configs at "/usr/lib/ignition/base.d" Jan 29 10:46:15.337604 ignition[1133]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:46:15.338563 ignition[1133]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:46:15.343104 ignition[1133]: PUT result: OK Jan 29 10:46:15.351243 ignition[1133]: kargs: kargs passed Jan 29 10:46:15.351372 ignition[1133]: Ignition finished successfully Jan 29 10:46:15.355808 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 29 10:46:15.372440 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 29 10:46:15.395976 ignition[1139]: Ignition 2.20.0 Jan 29 10:46:15.396006 ignition[1139]: Stage: disks Jan 29 10:46:15.396919 ignition[1139]: no configs at "/usr/lib/ignition/base.d" Jan 29 10:46:15.396946 ignition[1139]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:46:15.397198 ignition[1139]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:46:15.398181 ignition[1139]: PUT result: OK Jan 29 10:46:15.408533 ignition[1139]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Jan 29 10:46:15.421895 ignition[1139]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Jan 29 10:46:15.422111 ignition[1139]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/nvme0n1p9" Jan 29 10:46:15.422271 ignition[1139]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Jan 29 10:46:15.473310 ignition[1139]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Jan 29 10:46:15.473333 ignition[1139]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "88903c49-366d-43ff-90b1-141790b6e85c" and label "ROOT" Jan 29 10:46:15.473345 ignition[1139]: disks: createFilesystems: filesystem at "/dev/disk/by-partlabel/ROOT" is already correctly formatted. Skipping mkfs... Jan 29 10:46:15.473396 ignition[1139]: disks: disks passed Jan 29 10:46:15.486510 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 29 10:46:15.473584 ignition[1139]: Ignition finished successfully Jan 29 10:46:15.490565 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 29 10:46:15.493572 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 29 10:46:15.497226 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 10:46:15.499332 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 10:46:15.501383 systemd[1]: Reached target basic.target - Basic System. Jan 29 10:46:15.523342 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 29 10:46:15.575431 systemd-fsck[1147]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jan 29 10:46:15.582150 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 29 10:46:15.594282 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 29 10:46:15.673130 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 88903c49-366d-43ff-90b1-141790b6e85c r/w with ordered data mode. Quota mode: none. Jan 29 10:46:15.673549 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 29 10:46:15.677283 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 29 10:46:15.692222 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 10:46:15.695976 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 29 10:46:15.700706 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jan 29 10:46:15.700823 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 29 10:46:15.700880 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 29 10:46:15.730459 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 29 10:46:15.740664 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 29 10:46:15.754104 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/nvme0n1p6 scanned by mount (1166) Jan 29 10:46:15.758019 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 29 10:46:15.758103 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jan 29 10:46:15.760163 kernel: BTRFS info (device nvme0n1p6): using free space tree Jan 29 10:46:15.776082 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jan 29 10:46:15.778704 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 10:46:16.147880 initrd-setup-root[1190]: cut: /sysroot/etc/passwd: No such file or directory Jan 29 10:46:16.179809 initrd-setup-root[1197]: cut: /sysroot/etc/group: No such file or directory Jan 29 10:46:16.188319 initrd-setup-root[1204]: cut: /sysroot/etc/shadow: No such file or directory Jan 29 10:46:16.196174 initrd-setup-root[1211]: cut: /sysroot/etc/gshadow: No such file or directory Jan 29 10:46:16.621788 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 29 10:46:16.634257 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 29 10:46:16.644417 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 29 10:46:16.665860 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 29 10:46:16.667847 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 29 10:46:16.700217 systemd-networkd[1116]: eth0: Gained IPv6LL Jan 29 10:46:16.711147 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 29 10:46:16.722299 ignition[1279]: INFO : Ignition 2.20.0 Jan 29 10:46:16.725496 ignition[1279]: INFO : Stage: mount Jan 29 10:46:16.725496 ignition[1279]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 10:46:16.725496 ignition[1279]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:46:16.725496 ignition[1279]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:46:16.734780 ignition[1279]: INFO : PUT result: OK Jan 29 10:46:16.738664 ignition[1279]: INFO : mount: op(1): [started] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Jan 29 10:46:16.738664 ignition[1279]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "ext4" "/dev/disk/by-partlabel/ROOT" "/sysroot/tmp/_translate-filesystem-0-ign1" Jan 29 10:46:16.751579 ignition[1279]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Jan 29 10:46:16.751579 ignition[1279]: INFO : mount: mount passed Jan 29 10:46:16.751579 ignition[1279]: INFO : Ignition finished successfully Jan 29 10:46:16.762127 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 29 10:46:16.777255 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 29 10:46:16.792955 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 10:46:16.826110 kernel: BTRFS: device label OEM devid 1 transid 17 /dev/nvme0n1p6 scanned by mount (1291) Jan 29 10:46:16.830361 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 29 10:46:16.830442 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jan 29 10:46:16.830469 kernel: BTRFS info (device nvme0n1p6): using free space tree Jan 29 10:46:16.837114 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jan 29 10:46:16.841589 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 10:46:16.879644 ignition[1308]: INFO : Ignition 2.20.0 Jan 29 10:46:16.879644 ignition[1308]: INFO : Stage: files Jan 29 10:46:16.882929 ignition[1308]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 10:46:16.882929 ignition[1308]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:46:16.882929 ignition[1308]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:46:16.889788 ignition[1308]: INFO : PUT result: OK Jan 29 10:46:16.893779 ignition[1308]: DEBUG : files: compiled without relabeling support, skipping Jan 29 10:46:16.896234 ignition[1308]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 29 10:46:16.896234 ignition[1308]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 29 10:46:16.929902 ignition[1308]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 29 10:46:16.932973 ignition[1308]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 29 10:46:16.936285 unknown[1308]: wrote ssh authorized keys file for user: core Jan 29 10:46:16.940691 ignition[1308]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 29 10:46:16.940691 ignition[1308]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Jan 29 10:46:16.948232 ignition[1308]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Jan 29 10:46:16.948232 ignition[1308]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Jan 29 10:46:16.948232 ignition[1308]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Jan 29 10:46:16.948232 ignition[1308]: INFO : files: op(5): [started] processing unit "metadata.target" Jan 29 10:46:16.964624 ignition[1308]: INFO : files: op(5): op(6): [started] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Jan 29 10:46:16.971513 ignition[1308]: INFO : files: op(5): op(6): [finished] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Jan 29 10:46:16.971513 ignition[1308]: INFO : files: op(5): [finished] processing unit "metadata.target" Jan 29 10:46:16.971513 ignition[1308]: INFO : files: op(7): [started] setting preset to enabled for "coreos-metadata.service" Jan 29 10:46:16.971513 ignition[1308]: INFO : files: op(7): [finished] setting preset to enabled for "coreos-metadata.service" Jan 29 10:46:16.971513 ignition[1308]: INFO : files: op(8): [started] setting preset to enabled for "metadata.target" Jan 29 10:46:16.971513 ignition[1308]: INFO : files: op(8): [finished] setting preset to enabled for "metadata.target" Jan 29 10:46:16.971513 ignition[1308]: INFO : files: createResultFile: createFiles: op(9): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 29 10:46:16.971513 ignition[1308]: INFO : files: createResultFile: createFiles: op(9): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 29 10:46:16.971513 ignition[1308]: INFO : files: files passed Jan 29 10:46:16.971513 ignition[1308]: INFO : Ignition finished successfully Jan 29 10:46:16.995897 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 29 10:46:17.017512 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 29 10:46:17.025792 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 29 10:46:17.043665 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 29 10:46:17.043909 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 29 10:46:17.081601 initrd-setup-root-after-ignition[1336]: grep: Jan 29 10:46:17.083721 initrd-setup-root-after-ignition[1340]: grep: Jan 29 10:46:17.083721 initrd-setup-root-after-ignition[1336]: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 10:46:17.083721 initrd-setup-root-after-ignition[1336]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 29 10:46:17.092329 initrd-setup-root-after-ignition[1340]: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 10:46:17.096253 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 10:46:17.099180 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 29 10:46:17.117539 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 29 10:46:17.183185 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 29 10:46:17.185087 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 29 10:46:17.188346 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 29 10:46:17.190524 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 29 10:46:17.192831 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 29 10:46:17.213826 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 29 10:46:17.240672 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 10:46:17.251413 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 29 10:46:17.287904 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 29 10:46:17.290184 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 10:46:17.294792 systemd[1]: Stopped target timers.target - Timer Units. Jan 29 10:46:17.297031 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 29 10:46:17.297389 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 10:46:17.309560 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 29 10:46:17.313685 systemd[1]: Stopped target basic.target - Basic System. Jan 29 10:46:17.316457 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 29 10:46:17.319032 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 29 10:46:17.327603 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 29 10:46:17.330605 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 29 10:46:17.334502 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 10:46:17.337254 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 29 10:46:17.340230 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 29 10:46:17.343623 systemd[1]: Stopped target swap.target - Swaps. Jan 29 10:46:17.347638 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 29 10:46:17.347946 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 29 10:46:17.360151 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 29 10:46:17.362870 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 10:46:17.370322 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 29 10:46:17.370572 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 10:46:17.376007 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 29 10:46:17.376309 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 29 10:46:17.383985 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 29 10:46:17.384839 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 10:46:17.389510 systemd[1]: ignition-files.service: Deactivated successfully. Jan 29 10:46:17.389759 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 29 10:46:17.405437 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 29 10:46:17.413476 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 29 10:46:17.415352 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 29 10:46:17.415660 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 10:46:17.420342 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 29 10:46:17.422509 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 10:46:17.438625 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 29 10:46:17.438851 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 29 10:46:17.463439 ignition[1360]: INFO : Ignition 2.20.0 Jan 29 10:46:17.466260 ignition[1360]: INFO : Stage: umount Jan 29 10:46:17.466260 ignition[1360]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 10:46:17.466260 ignition[1360]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:46:17.472559 ignition[1360]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:46:17.475824 ignition[1360]: INFO : PUT result: OK Jan 29 10:46:17.480039 ignition[1360]: INFO : umount: op(1): [started] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Jan 29 10:46:17.480039 ignition[1360]: INFO : umount: op(1): [finished] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Jan 29 10:46:17.480039 ignition[1360]: INFO : umount: umount passed Jan 29 10:46:17.480039 ignition[1360]: INFO : Ignition finished successfully Jan 29 10:46:17.486043 systemd[1]: sysroot-tmp-_translate\x2dfilesystem\x2d0\x2dign1.mount: Deactivated successfully. Jan 29 10:46:17.490324 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 29 10:46:17.490649 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 29 10:46:17.501785 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 29 10:46:17.506907 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 29 10:46:17.507095 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 29 10:46:17.516322 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 29 10:46:17.516447 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 29 10:46:17.518714 systemd[1]: ignition-fetch.service: Deactivated successfully. Jan 29 10:46:17.518828 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jan 29 10:46:17.521293 systemd[1]: Stopped target network.target - Network. Jan 29 10:46:17.525554 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 29 10:46:17.525677 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 29 10:46:17.533529 systemd[1]: Stopped target paths.target - Path Units. Jan 29 10:46:17.534150 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 29 10:46:17.543990 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 10:46:17.546460 systemd[1]: Stopped target slices.target - Slice Units. Jan 29 10:46:17.548273 systemd[1]: Stopped target sockets.target - Socket Units. Jan 29 10:46:17.550303 systemd[1]: iscsid.socket: Deactivated successfully. Jan 29 10:46:17.550390 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 10:46:17.552680 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 29 10:46:17.552769 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 10:46:17.555388 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 29 10:46:17.555515 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 29 10:46:17.565706 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 29 10:46:17.565818 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 29 10:46:17.576773 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 29 10:46:17.580087 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 29 10:46:17.584424 systemd-networkd[1116]: eth0: DHCPv6 lease lost Jan 29 10:46:17.593297 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 29 10:46:17.593523 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 29 10:46:17.600325 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 29 10:46:17.602172 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 29 10:46:17.611074 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 29 10:46:17.613614 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 29 10:46:17.621897 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 29 10:46:17.622011 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 29 10:46:17.624944 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 29 10:46:17.625125 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 29 10:46:17.641562 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 29 10:46:17.644073 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 29 10:46:17.644192 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 29 10:46:17.646673 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 29 10:46:17.646763 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 29 10:46:17.650258 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 29 10:46:17.650363 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 29 10:46:17.652767 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 29 10:46:17.652870 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 10:46:17.655904 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 10:46:17.719255 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 29 10:46:17.719588 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 10:46:17.725358 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 29 10:46:17.728188 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 29 10:46:17.733815 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 29 10:46:17.733934 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 29 10:46:17.736272 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 29 10:46:17.736346 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 10:46:17.738604 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 29 10:46:17.738712 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 29 10:46:17.741682 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 29 10:46:17.741796 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 29 10:46:17.759428 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 10:46:17.759542 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 10:46:17.776291 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 29 10:46:17.778639 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 29 10:46:17.778751 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 10:46:17.781321 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jan 29 10:46:17.781410 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 10:46:17.800591 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 29 10:46:17.800695 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 10:46:17.805278 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 10:46:17.805377 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 10:46:17.811242 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 29 10:46:17.813104 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 29 10:46:17.828882 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 29 10:46:17.842422 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 29 10:46:17.857564 systemd[1]: Switching root. Jan 29 10:46:17.894630 systemd-journald[251]: Journal stopped Jan 29 10:46:20.197280 systemd-journald[251]: Received SIGTERM from PID 1 (systemd). Jan 29 10:46:20.197427 kernel: SELinux: policy capability network_peer_controls=1 Jan 29 10:46:20.197481 kernel: SELinux: policy capability open_perms=1 Jan 29 10:46:20.197514 kernel: SELinux: policy capability extended_socket_class=1 Jan 29 10:46:20.197553 kernel: SELinux: policy capability always_check_network=0 Jan 29 10:46:20.197586 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 29 10:46:20.197620 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 29 10:46:20.197662 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 29 10:46:20.197694 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 29 10:46:20.197725 kernel: audit: type=1403 audit(1738147578.319:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 29 10:46:20.197765 systemd[1]: Successfully loaded SELinux policy in 66.794ms. Jan 29 10:46:20.197824 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 30.647ms. Jan 29 10:46:20.197863 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) Jan 29 10:46:20.197902 systemd[1]: Detected virtualization amazon. Jan 29 10:46:20.197937 systemd[1]: Detected architecture arm64. Jan 29 10:46:20.197968 systemd[1]: Detected first boot. Jan 29 10:46:20.198003 systemd[1]: Initializing machine ID from VM UUID. Jan 29 10:46:20.198036 zram_generator::config[1403]: No configuration found. Jan 29 10:46:20.198126 systemd[1]: Populated /etc with preset unit settings. Jan 29 10:46:20.198163 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 29 10:46:20.198195 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 29 10:46:20.198236 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 29 10:46:20.198268 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 29 10:46:20.198300 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 29 10:46:20.198333 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 29 10:46:20.198363 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 29 10:46:20.198397 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 29 10:46:20.198431 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 29 10:46:20.198462 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 29 10:46:20.198494 systemd[1]: Created slice user.slice - User and Session Slice. Jan 29 10:46:20.198532 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 10:46:20.198567 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 10:46:20.198602 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 29 10:46:20.198633 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 29 10:46:20.198666 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 29 10:46:20.198699 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 10:46:20.198781 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jan 29 10:46:20.198816 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 10:46:20.198848 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 29 10:46:20.198889 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 29 10:46:20.198922 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 29 10:46:20.198954 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 29 10:46:20.198983 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 10:46:20.199015 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 10:46:20.199087 systemd[1]: Reached target slices.target - Slice Units. Jan 29 10:46:20.199127 systemd[1]: Reached target swap.target - Swaps. Jan 29 10:46:20.199160 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 29 10:46:20.199204 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 29 10:46:20.199236 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 10:46:20.199271 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 10:46:20.199301 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 10:46:20.199332 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 29 10:46:20.199364 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 29 10:46:20.199394 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 29 10:46:20.199428 systemd[1]: Mounting media.mount - External Media Directory... Jan 29 10:46:20.199461 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 29 10:46:20.199498 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 29 10:46:20.199529 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jan 29 10:46:20.199559 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 29 10:46:20.199594 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). Jan 29 10:46:20.199631 systemd[1]: Reached target machines.target - Containers. Jan 29 10:46:20.199660 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 29 10:46:20.199690 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 10:46:20.199720 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 10:46:20.199755 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 29 10:46:20.199787 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 10:46:20.199818 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 10:46:20.199848 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 10:46:20.199877 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 29 10:46:20.199908 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 10:46:20.199940 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 29 10:46:20.199972 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 29 10:46:20.200019 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 29 10:46:20.200106 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 29 10:46:20.200144 systemd[1]: Stopped systemd-fsck-usr.service. Jan 29 10:46:20.200174 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 10:46:20.200203 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 10:46:20.200233 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 29 10:46:20.200267 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 29 10:46:20.200297 kernel: fuse: init (API version 7.39) Jan 29 10:46:20.200326 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 10:46:20.200359 systemd[1]: verity-setup.service: Deactivated successfully. Jan 29 10:46:20.200396 systemd[1]: Stopped verity-setup.service. Jan 29 10:46:20.200427 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 29 10:46:20.200457 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 29 10:46:20.200485 kernel: loop: module loaded Jan 29 10:46:20.200517 systemd[1]: Mounted media.mount - External Media Directory. Jan 29 10:46:20.200550 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 29 10:46:20.200582 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 29 10:46:20.200618 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 29 10:46:20.200650 kernel: ACPI: bus type drm_connector registered Jan 29 10:46:20.200681 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 10:46:20.200713 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 29 10:46:20.200742 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 29 10:46:20.200774 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 10:46:20.200811 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 10:46:20.200843 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 29 10:46:20.200874 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 10:46:20.200904 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 10:46:20.200988 systemd-journald[1488]: Collecting audit messages is disabled. Jan 29 10:46:20.201156 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 10:46:20.201204 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 10:46:20.201235 systemd-journald[1488]: Journal started Jan 29 10:46:20.201297 systemd-journald[1488]: Runtime Journal (/run/log/journal/ec2e1ec7d9f68efef88be29f485c952c) is 8.0M, max 75.3M, 67.3M free. Jan 29 10:46:19.567911 systemd[1]: Queued start job for default target multi-user.target. Jan 29 10:46:19.601979 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Jan 29 10:46:19.602757 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 29 10:46:20.215571 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 10:46:20.219613 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 29 10:46:20.220028 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 29 10:46:20.225624 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 10:46:20.228189 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 10:46:20.233815 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 10:46:20.240603 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 29 10:46:20.247140 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 29 10:46:20.284987 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 29 10:46:20.295318 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 29 10:46:20.308810 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 29 10:46:20.311115 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 29 10:46:20.311181 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 10:46:20.319448 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jan 29 10:46:20.331393 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 29 10:46:20.343587 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 29 10:46:20.348494 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 10:46:20.353348 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 29 10:46:20.362791 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 29 10:46:20.366306 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 10:46:20.376403 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 29 10:46:20.378671 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 10:46:20.385458 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 10:46:20.397773 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 29 10:46:20.412553 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 29 10:46:20.419355 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 29 10:46:20.423620 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 29 10:46:20.428173 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 29 10:46:20.450474 systemd-journald[1488]: Time spent on flushing to /var/log/journal/ec2e1ec7d9f68efef88be29f485c952c is 140.189ms for 909 entries. Jan 29 10:46:20.450474 systemd-journald[1488]: System Journal (/var/log/journal/ec2e1ec7d9f68efef88be29f485c952c) is 8.0M, max 195.6M, 187.6M free. Jan 29 10:46:20.603105 systemd-journald[1488]: Received client request to flush runtime journal. Jan 29 10:46:20.603808 kernel: loop0: detected capacity change from 0 to 116784 Jan 29 10:46:20.465106 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 29 10:46:20.468604 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jan 29 10:46:20.478937 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jan 29 10:46:20.541255 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 10:46:20.552396 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jan 29 10:46:20.619857 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 29 10:46:20.623101 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 10:46:20.635340 udevadm[1542]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Jan 29 10:46:20.639382 systemd-tmpfiles[1533]: ACLs are not supported, ignoring. Jan 29 10:46:20.639418 systemd-tmpfiles[1533]: ACLs are not supported, ignoring. Jan 29 10:46:20.643745 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 29 10:46:20.650233 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jan 29 10:46:20.680077 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 29 10:46:20.680683 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 10:46:20.692847 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 29 10:46:20.733762 kernel: loop1: detected capacity change from 0 to 113552 Jan 29 10:46:20.797267 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 29 10:46:20.814571 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 10:46:20.861973 systemd-tmpfiles[1554]: ACLs are not supported, ignoring. Jan 29 10:46:20.862019 systemd-tmpfiles[1554]: ACLs are not supported, ignoring. Jan 29 10:46:20.880196 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 10:46:20.886093 kernel: loop2: detected capacity change from 0 to 53784 Jan 29 10:46:21.035104 kernel: loop3: detected capacity change from 0 to 116784 Jan 29 10:46:21.067100 kernel: loop4: detected capacity change from 0 to 113552 Jan 29 10:46:21.089149 kernel: loop5: detected capacity change from 0 to 53784 Jan 29 10:46:21.109189 (sd-merge)[1559]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Jan 29 10:46:21.110249 (sd-merge)[1559]: Merged extensions into '/usr'. Jan 29 10:46:21.127570 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 29 10:46:21.140562 systemd[1]: Starting ensure-sysext.service... Jan 29 10:46:21.156271 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 10:46:21.172287 systemd[1]: Reloading requested from client PID 1561 ('systemctl') (unit ensure-sysext.service)... Jan 29 10:46:21.172323 systemd[1]: Reloading... Jan 29 10:46:21.263934 systemd-tmpfiles[1562]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 29 10:46:21.264562 systemd-tmpfiles[1562]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 29 10:46:21.272158 systemd-tmpfiles[1562]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 29 10:46:21.273099 systemd-tmpfiles[1562]: ACLs are not supported, ignoring. Jan 29 10:46:21.273269 systemd-tmpfiles[1562]: ACLs are not supported, ignoring. Jan 29 10:46:21.288804 systemd-tmpfiles[1562]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 10:46:21.289254 systemd-tmpfiles[1562]: Skipping /boot Jan 29 10:46:21.338098 systemd-tmpfiles[1562]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 10:46:21.338124 systemd-tmpfiles[1562]: Skipping /boot Jan 29 10:46:21.431110 zram_generator::config[1589]: No configuration found. Jan 29 10:46:21.808146 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. Jan 29 10:46:21.943595 systemd[1]: Reloading finished in 770 ms. Jan 29 10:46:21.988075 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 29 10:46:21.999738 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 10:46:22.019579 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 10:46:22.038145 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 29 10:46:22.044270 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 29 10:46:22.057481 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 10:46:22.070443 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 10:46:22.082524 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 29 10:46:22.098204 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 10:46:22.106266 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 10:46:22.115459 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 10:46:22.127578 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 10:46:22.130402 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 10:46:22.137383 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 10:46:22.138372 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 10:46:22.154971 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 10:46:22.164885 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 10:46:22.167679 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 10:46:22.168566 systemd[1]: Reached target time-set.target - System Time Set. Jan 29 10:46:22.186571 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 29 10:46:22.198177 systemd[1]: Finished ensure-sysext.service. Jan 29 10:46:22.206168 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 29 10:46:22.235763 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 10:46:22.240547 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 10:46:22.245098 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 10:46:22.249459 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 10:46:22.251223 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 10:46:22.263010 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 10:46:22.263978 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 10:46:22.297026 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 10:46:22.297544 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 10:46:22.302292 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 10:46:22.303845 systemd-udevd[1647]: Using default interface naming scheme 'v255'. Jan 29 10:46:22.310189 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 29 10:46:22.401113 augenrules[1680]: No rules Jan 29 10:46:22.408742 ldconfig[1527]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 29 10:46:22.405405 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 10:46:22.410014 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 10:46:22.410524 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 10:46:22.430641 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 10:46:22.434175 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 29 10:46:22.437181 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 29 10:46:22.471406 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 29 10:46:22.474440 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). Jan 29 10:46:22.474727 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 29 10:46:22.520461 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 29 10:46:22.670218 systemd-networkd[1690]: lo: Link UP Jan 29 10:46:22.670853 systemd-networkd[1690]: lo: Gained carrier Jan 29 10:46:22.691297 (udev-worker)[1709]: Network interface NamePolicy= disabled on kernel command line. Jan 29 10:46:22.702189 systemd-resolved[1646]: Positive Trust Anchors: Jan 29 10:46:22.703103 systemd-resolved[1646]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 10:46:22.703174 systemd-resolved[1646]: 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 Jan 29 10:46:22.705366 systemd-networkd[1690]: Enumeration completed Jan 29 10:46:22.707875 systemd-networkd[1690]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 10:46:22.707895 systemd-networkd[1690]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 10:46:22.708418 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 10:46:22.712658 systemd-networkd[1690]: eth0: Link UP Jan 29 10:46:22.715880 systemd-networkd[1690]: eth0: Gained carrier Jan 29 10:46:22.715937 systemd-networkd[1690]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 10:46:22.724923 systemd-resolved[1646]: Defaulting to hostname 'linux'. Jan 29 10:46:22.732237 systemd-networkd[1690]: eth0: DHCPv4 address 172.31.25.38/20, gateway 172.31.16.1 acquired from 172.31.16.1 Jan 29 10:46:22.735750 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 29 10:46:22.740281 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 10:46:22.743962 systemd[1]: Reached target network.target - Network. Jan 29 10:46:22.746288 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 10:46:22.764021 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jan 29 10:46:22.827605 systemd-networkd[1690]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 10:46:23.008572 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 10:46:23.046106 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 39 scanned by (udev-worker) (1688) Jan 29 10:46:23.194809 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 10:46:23.254343 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Jan 29 10:46:23.259140 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jan 29 10:46:23.276447 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jan 29 10:46:23.293471 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 29 10:46:23.300108 lvm[1819]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 10:46:23.333420 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 29 10:46:23.339227 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jan 29 10:46:23.343763 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 10:46:23.346393 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 10:46:23.348862 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 29 10:46:23.351473 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jan 29 10:46:23.354979 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 29 10:46:23.357531 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 29 10:46:23.359998 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 29 10:46:23.362458 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 29 10:46:23.362529 systemd[1]: Reached target paths.target - Path Units. Jan 29 10:46:23.364863 systemd[1]: Reached target timers.target - Timer Units. Jan 29 10:46:23.369573 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 29 10:46:23.374721 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 29 10:46:23.385912 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 29 10:46:23.395446 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jan 29 10:46:23.399830 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 29 10:46:23.402406 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 10:46:23.405025 systemd[1]: Reached target basic.target - Basic System. Jan 29 10:46:23.407308 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 29 10:46:23.407383 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 29 10:46:23.417336 systemd[1]: Starting containerd.service - containerd container runtime... Jan 29 10:46:23.423438 lvm[1826]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 10:46:23.425239 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jan 29 10:46:23.437445 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 29 10:46:23.444370 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 29 10:46:23.450417 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 29 10:46:23.452570 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). Jan 29 10:46:23.460396 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 29 10:46:23.466477 systemd[1]: Started ntpd.service - Network Time Service. Jan 29 10:46:23.472861 systemd[1]: Starting setup-oem.service - Setup OEM... Jan 29 10:46:23.480425 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 29 10:46:23.487469 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 29 10:46:23.500442 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 29 10:46:23.504195 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jan 29 10:46:23.507328 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 29 10:46:23.536422 systemd[1]: Starting update-engine.service - Update Engine... Jan 29 10:46:23.565980 jq[1830]: false Jan 29 10:46:23.569547 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 29 10:46:23.601344 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jan 29 10:46:23.609941 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 29 10:46:23.610756 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 29 10:46:23.612994 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 29 10:46:23.613469 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 29 10:46:23.624013 jq[1839]: true Jan 29 10:46:23.678807 jq[1850]: true Jan 29 10:46:23.691330 ntpd[1833]: ntpd 4.2.8p17@1.4004-o Wed Jan 29 09:00:26 UTC 2025 (1): Starting Jan 29 10:46:23.715307 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: ntpd 4.2.8p17@1.4004-o Wed Jan 29 09:00:26 UTC 2025 (1): Starting Jan 29 10:46:23.715307 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Jan 29 10:46:23.715307 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: ---------------------------------------------------- Jan 29 10:46:23.715307 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: ntp-4 is maintained by Network Time Foundation, Jan 29 10:46:23.715307 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Jan 29 10:46:23.715307 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: corporation. Support and training for ntp-4 are Jan 29 10:46:23.715307 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: available at https://www.nwtime.org/support Jan 29 10:46:23.715307 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: ---------------------------------------------------- Jan 29 10:46:23.715307 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: proto: precision = 0.096 usec (-23) Jan 29 10:46:23.691402 ntpd[1833]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Jan 29 10:46:23.691423 ntpd[1833]: ---------------------------------------------------- Jan 29 10:46:23.691443 ntpd[1833]: ntp-4 is maintained by Network Time Foundation, Jan 29 10:46:23.691461 ntpd[1833]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Jan 29 10:46:23.691479 ntpd[1833]: corporation. Support and training for ntp-4 are Jan 29 10:46:23.691496 ntpd[1833]: available at https://www.nwtime.org/support Jan 29 10:46:23.691519 ntpd[1833]: ---------------------------------------------------- Jan 29 10:46:23.713530 ntpd[1833]: proto: precision = 0.096 usec (-23) Jan 29 10:46:23.718465 ntpd[1833]: basedate set to 2025-01-17 Jan 29 10:46:23.719182 (ntainerd)[1861]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: basedate set to 2025-01-17 Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: gps base set to 2025-01-19 (week 2350) Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: Listen and drop on 0 v6wildcard [::]:123 Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: Listen normally on 2 lo 127.0.0.1:123 Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: Listen normally on 3 eth0 172.31.25.38:123 Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: Listen normally on 4 lo [::1]:123 Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: bind(21) AF_INET6 fe80::489:edff:fee3:6d9%2#123 flags 0x11 failed: Cannot assign requested address Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: unable to create socket on eth0 (5) for fe80::489:edff:fee3:6d9%2#123 Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: failed to init interface for address fe80::489:edff:fee3:6d9%2 Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: Listening on routing socket on fd #21 for interface updates Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 29 10:46:23.747365 ntpd[1833]: 29 Jan 10:46:23 ntpd[1833]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 29 10:46:23.718522 ntpd[1833]: gps base set to 2025-01-19 (week 2350) Jan 29 10:46:23.727954 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 29 10:46:23.763495 extend-filesystems[1831]: Found loop3 Jan 29 10:46:23.763495 extend-filesystems[1831]: Found loop4 Jan 29 10:46:23.763495 extend-filesystems[1831]: Found loop5 Jan 29 10:46:23.763495 extend-filesystems[1831]: Found nvme0n1 Jan 29 10:46:23.763495 extend-filesystems[1831]: Found nvme0n1p1 Jan 29 10:46:23.763495 extend-filesystems[1831]: Found nvme0n1p2 Jan 29 10:46:23.763495 extend-filesystems[1831]: Found nvme0n1p3 Jan 29 10:46:23.763495 extend-filesystems[1831]: Found usr Jan 29 10:46:23.763495 extend-filesystems[1831]: Found nvme0n1p4 Jan 29 10:46:23.763495 extend-filesystems[1831]: Found nvme0n1p6 Jan 29 10:46:23.763495 extend-filesystems[1831]: Found nvme0n1p7 Jan 29 10:46:23.763495 extend-filesystems[1831]: Found nvme0n1p9 Jan 29 10:46:23.763495 extend-filesystems[1831]: Checking size of /dev/nvme0n1p9 Jan 29 10:46:23.725319 ntpd[1833]: Listen and drop on 0 v6wildcard [::]:123 Jan 29 10:46:23.737311 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). Jan 29 10:46:23.857426 update_engine[1838]: I20250129 10:46:23.786955 1838 main.cc:92] Flatcar Update Engine starting Jan 29 10:46:23.857426 update_engine[1838]: I20250129 10:46:23.851074 1838 update_check_scheduler.cc:74] Next update check in 7m4s Jan 29 10:46:23.725407 ntpd[1833]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jan 29 10:46:23.737372 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 29 10:46:23.867693 extend-filesystems[1831]: Resized partition /dev/nvme0n1p9 Jan 29 10:46:23.727621 dbus-daemon[1829]: [system] SELinux support is enabled Jan 29 10:46:23.740328 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). Jan 29 10:46:23.731884 ntpd[1833]: Listen normally on 2 lo 127.0.0.1:123 Jan 29 10:46:23.740381 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 29 10:46:23.892494 extend-filesystems[1886]: resize2fs 1.47.1 (20-May-2024) Jan 29 10:46:23.731975 ntpd[1833]: Listen normally on 3 eth0 172.31.25.38:123 Jan 29 10:46:23.810705 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 29 10:46:23.732072 ntpd[1833]: Listen normally on 4 lo [::1]:123 Jan 29 10:46:23.835376 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Jan 29 10:46:23.732170 ntpd[1833]: bind(21) AF_INET6 fe80::489:edff:fee3:6d9%2#123 flags 0x11 failed: Cannot assign requested address Jan 29 10:46:23.846722 systemd[1]: Started update-engine.service - Update Engine. Jan 29 10:46:23.732216 ntpd[1833]: unable to create socket on eth0 (5) for fe80::489:edff:fee3:6d9%2#123 Jan 29 10:46:23.874503 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 29 10:46:23.732244 ntpd[1833]: failed to init interface for address fe80::489:edff:fee3:6d9%2 Jan 29 10:46:23.877837 systemd[1]: motdgen.service: Deactivated successfully. Jan 29 10:46:23.732310 ntpd[1833]: Listening on routing socket on fd #21 for interface updates Jan 29 10:46:23.878239 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 29 10:46:23.746920 ntpd[1833]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 29 10:46:23.746986 ntpd[1833]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 29 10:46:23.783633 dbus-daemon[1829]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1690 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Jan 29 10:46:23.917171 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Jan 29 10:46:23.935173 systemd[1]: Finished setup-oem.service - Setup OEM. Jan 29 10:46:24.058115 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Jan 29 10:46:24.062245 coreos-metadata[1828]: Jan 29 10:46:24.062 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Jan 29 10:46:24.076216 coreos-metadata[1828]: Jan 29 10:46:24.069 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Jan 29 10:46:24.076216 coreos-metadata[1828]: Jan 29 10:46:24.070 INFO Fetch successful Jan 29 10:46:24.076216 coreos-metadata[1828]: Jan 29 10:46:24.070 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Jan 29 10:46:24.076216 coreos-metadata[1828]: Jan 29 10:46:24.074 INFO Fetch successful Jan 29 10:46:24.076216 coreos-metadata[1828]: Jan 29 10:46:24.074 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Jan 29 10:46:24.078442 coreos-metadata[1828]: Jan 29 10:46:24.078 INFO Fetch successful Jan 29 10:46:24.078442 coreos-metadata[1828]: Jan 29 10:46:24.078 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Jan 29 10:46:24.082196 extend-filesystems[1886]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Jan 29 10:46:24.082196 extend-filesystems[1886]: old_desc_blocks = 1, new_desc_blocks = 1 Jan 29 10:46:24.082196 extend-filesystems[1886]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Jan 29 10:46:24.135430 bash[1902]: Updated "/home/core/.ssh/authorized_keys" Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.088 INFO Fetch successful Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.088 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.105 INFO Fetch failed with 404: resource not found Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.105 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.113 INFO Fetch successful Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.113 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.114 INFO Fetch successful Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.114 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.116 INFO Fetch successful Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.116 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.119 INFO Fetch successful Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.120 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Jan 29 10:46:24.135647 coreos-metadata[1828]: Jan 29 10:46:24.125 INFO Fetch successful Jan 29 10:46:24.136438 extend-filesystems[1831]: Resized filesystem in /dev/nvme0n1p9 Jan 29 10:46:24.085753 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 29 10:46:24.086337 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 29 10:46:24.099480 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jan 29 10:46:24.122354 systemd[1]: Starting sshkeys.service... Jan 29 10:46:24.188176 systemd-networkd[1690]: eth0: Gained IPv6LL Jan 29 10:46:24.215268 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 29 10:46:24.226418 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Jan 29 10:46:24.230549 systemd[1]: Reached target network-online.target - Network is Online. Jan 29 10:46:24.239652 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Jan 29 10:46:24.249290 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 39 scanned by (udev-worker) (1688) Jan 29 10:46:24.250290 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Jan 29 10:46:24.257647 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 29 10:46:24.378432 systemd-logind[1837]: Watching system buttons on /dev/input/event0 (Power Button) Jan 29 10:46:24.378487 systemd-logind[1837]: Watching system buttons on /dev/input/event1 (Sleep Button) Jan 29 10:46:24.383856 systemd-logind[1837]: New seat seat0. Jan 29 10:46:24.396403 systemd[1]: Started systemd-logind.service - User Login Management. Jan 29 10:46:24.455948 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jan 29 10:46:24.459276 systemd[1]: Reached target metadata.target. Jan 29 10:46:24.461575 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jan 29 10:46:24.482222 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 29 10:46:24.485990 containerd[1861]: time="2025-01-29T10:46:24.481565397Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Jan 29 10:46:24.547003 amazon-ssm-agent[1919]: Initializing new seelog logger Jan 29 10:46:24.550084 amazon-ssm-agent[1919]: New Seelog Logger Creation Complete Jan 29 10:46:24.550084 amazon-ssm-agent[1919]: 2025/01/29 10:46:24 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:46:24.550084 amazon-ssm-agent[1919]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:46:24.551769 amazon-ssm-agent[1919]: 2025/01/29 10:46:24 processing appconfig overrides Jan 29 10:46:24.558078 amazon-ssm-agent[1919]: 2025/01/29 10:46:24 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:46:24.558078 amazon-ssm-agent[1919]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:46:24.558078 amazon-ssm-agent[1919]: 2025/01/29 10:46:24 processing appconfig overrides Jan 29 10:46:24.558078 amazon-ssm-agent[1919]: 2025/01/29 10:46:24 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:46:24.558078 amazon-ssm-agent[1919]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:46:24.558078 amazon-ssm-agent[1919]: 2025/01/29 10:46:24 processing appconfig overrides Jan 29 10:46:24.559727 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO Proxy environment variables: Jan 29 10:46:24.566476 amazon-ssm-agent[1919]: 2025/01/29 10:46:24 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:46:24.566476 amazon-ssm-agent[1919]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:46:24.566661 amazon-ssm-agent[1919]: 2025/01/29 10:46:24 processing appconfig overrides Jan 29 10:46:24.596360 dbus-daemon[1829]: [system] Successfully activated service 'org.freedesktop.hostname1' Jan 29 10:46:24.596663 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Jan 29 10:46:24.606385 dbus-daemon[1829]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1874 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Jan 29 10:46:24.637846 containerd[1861]: time="2025-01-29T10:46:24.636552754Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jan 29 10:46:24.639871 containerd[1861]: time="2025-01-29T10:46:24.639772030Z" 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.74-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jan 29 10:46:24.639871 containerd[1861]: time="2025-01-29T10:46:24.639852394Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jan 29 10:46:24.640085 containerd[1861]: time="2025-01-29T10:46:24.639891658Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jan 29 10:46:24.640412 containerd[1861]: time="2025-01-29T10:46:24.640340974Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jan 29 10:46:24.640540 containerd[1861]: time="2025-01-29T10:46:24.640415542Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jan 29 10:46:24.640645 containerd[1861]: time="2025-01-29T10:46:24.640585270Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 10:46:24.640708 containerd[1861]: time="2025-01-29T10:46:24.640638082Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jan 29 10:46:24.641779 containerd[1861]: time="2025-01-29T10:46:24.641030842Z" 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 Jan 29 10:46:24.641779 containerd[1861]: time="2025-01-29T10:46:24.641440654Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jan 29 10:46:24.641779 containerd[1861]: time="2025-01-29T10:46:24.641502094Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 10:46:24.641779 containerd[1861]: time="2025-01-29T10:46:24.641533894Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jan 29 10:46:24.642038 containerd[1861]: time="2025-01-29T10:46:24.641838922Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jan 29 10:46:24.644608 containerd[1861]: time="2025-01-29T10:46:24.642348022Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jan 29 10:46:24.644608 containerd[1861]: time="2025-01-29T10:46:24.642682390Z" 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 Jan 29 10:46:24.644608 containerd[1861]: time="2025-01-29T10:46:24.642728026Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jan 29 10:46:24.644608 containerd[1861]: time="2025-01-29T10:46:24.642963730Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jan 29 10:46:24.644608 containerd[1861]: time="2025-01-29T10:46:24.643106818Z" level=info msg="metadata content store policy set" policy=shared Jan 29 10:46:24.648900 systemd[1]: Starting polkit.service - Authorization Manager... Jan 29 10:46:24.654389 coreos-metadata[1921]: Jan 29 10:46:24.647 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Jan 29 10:46:24.661127 coreos-metadata[1921]: Jan 29 10:46:24.655 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Jan 29 10:46:24.661127 coreos-metadata[1921]: Jan 29 10:46:24.659 INFO Fetch successful Jan 29 10:46:24.661127 coreos-metadata[1921]: Jan 29 10:46:24.659 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Jan 29 10:46:24.661388 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO https_proxy: Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.655322698Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.655406398Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.655441810Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.655482118Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.655517830Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.656801902Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.657335542Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.657623122Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.657665062Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.657698566Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.657731410Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.657768106Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.657800374Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jan 29 10:46:24.661450 containerd[1861]: time="2025-01-29T10:46:24.657833458Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jan 29 10:46:24.662026 containerd[1861]: time="2025-01-29T10:46:24.657867598Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jan 29 10:46:24.662026 containerd[1861]: time="2025-01-29T10:46:24.657899770Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jan 29 10:46:24.662026 containerd[1861]: time="2025-01-29T10:46:24.657928510Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jan 29 10:46:24.662026 containerd[1861]: time="2025-01-29T10:46:24.657957022Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jan 29 10:46:24.662026 containerd[1861]: time="2025-01-29T10:46:24.657997906Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.662026 containerd[1861]: time="2025-01-29T10:46:24.658031890Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.665622 coreos-metadata[1921]: Jan 29 10:46:24.663 INFO Fetch successful Jan 29 10:46:24.669132 containerd[1861]: time="2025-01-29T10:46:24.666998842Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.669132 containerd[1861]: time="2025-01-29T10:46:24.667155850Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.669132 containerd[1861]: time="2025-01-29T10:46:24.667191178Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.669132 containerd[1861]: time="2025-01-29T10:46:24.667271218Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.669132 containerd[1861]: time="2025-01-29T10:46:24.667358254Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.669897 unknown[1921]: wrote ssh authorized keys file for user: core Jan 29 10:46:24.672486 containerd[1861]: time="2025-01-29T10:46:24.668170882Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.672486 containerd[1861]: time="2025-01-29T10:46:24.671365630Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.672486 containerd[1861]: time="2025-01-29T10:46:24.671438926Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.672486 containerd[1861]: time="2025-01-29T10:46:24.671588626Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.674230 polkitd[1973]: Started polkitd version 121 Jan 29 10:46:24.680865 containerd[1861]: time="2025-01-29T10:46:24.671627470Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.680865 containerd[1861]: time="2025-01-29T10:46:24.674731666Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.680865 containerd[1861]: time="2025-01-29T10:46:24.674828818Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jan 29 10:46:24.680865 containerd[1861]: time="2025-01-29T10:46:24.674922070Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.680865 containerd[1861]: time="2025-01-29T10:46:24.674966398Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.680865 containerd[1861]: time="2025-01-29T10:46:24.676296322Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jan 29 10:46:24.684476 containerd[1861]: time="2025-01-29T10:46:24.683707738Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jan 29 10:46:24.684476 containerd[1861]: time="2025-01-29T10:46:24.683811322Z" 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 Jan 29 10:46:24.684476 containerd[1861]: time="2025-01-29T10:46:24.683874154Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jan 29 10:46:24.684476 containerd[1861]: time="2025-01-29T10:46:24.683909902Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jan 29 10:46:24.684476 containerd[1861]: time="2025-01-29T10:46:24.683936194Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.684476 containerd[1861]: time="2025-01-29T10:46:24.683996578Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jan 29 10:46:24.684476 containerd[1861]: time="2025-01-29T10:46:24.684022354Z" level=info msg="NRI interface is disabled by configuration." Jan 29 10:46:24.684476 containerd[1861]: time="2025-01-29T10:46:24.684093562Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jan 29 10:46:24.695994 containerd[1861]: time="2025-01-29T10:46:24.694257610Z" 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}" Jan 29 10:46:24.695994 containerd[1861]: time="2025-01-29T10:46:24.694527310Z" level=info msg="Connect containerd service" Jan 29 10:46:24.695994 containerd[1861]: time="2025-01-29T10:46:24.695310406Z" level=info msg="using legacy CRI server" Jan 29 10:46:24.695994 containerd[1861]: time="2025-01-29T10:46:24.695672242Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 29 10:46:24.701225 containerd[1861]: time="2025-01-29T10:46:24.699146890Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jan 29 10:46:24.699400 polkitd[1973]: Loading rules from directory /etc/polkit-1/rules.d Jan 29 10:46:24.699521 polkitd[1973]: Loading rules from directory /usr/share/polkit-1/rules.d Jan 29 10:46:24.701542 polkitd[1973]: Finished loading, compiling and executing 2 rules Jan 29 10:46:24.703967 containerd[1861]: time="2025-01-29T10:46:24.703887334Z" 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" Jan 29 10:46:24.708037 dbus-daemon[1829]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jan 29 10:46:24.708924 containerd[1861]: time="2025-01-29T10:46:24.708752290Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 29 10:46:24.709098 containerd[1861]: time="2025-01-29T10:46:24.709015714Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 29 10:46:24.709167 polkitd[1973]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Jan 29 10:46:24.712239 containerd[1861]: time="2025-01-29T10:46:24.710690098Z" level=info msg="Start subscribing containerd event" Jan 29 10:46:24.712239 containerd[1861]: time="2025-01-29T10:46:24.710999086Z" level=info msg="Start recovering state" Jan 29 10:46:24.712239 containerd[1861]: time="2025-01-29T10:46:24.711199090Z" level=info msg="Start event monitor" Jan 29 10:46:24.712239 containerd[1861]: time="2025-01-29T10:46:24.711230734Z" level=info msg="Start snapshots syncer" Jan 29 10:46:24.712239 containerd[1861]: time="2025-01-29T10:46:24.711267022Z" level=info msg="Start cni network conf syncer for default" Jan 29 10:46:24.712239 containerd[1861]: time="2025-01-29T10:46:24.711296434Z" level=info msg="Start streaming server" Jan 29 10:46:24.712239 containerd[1861]: time="2025-01-29T10:46:24.711562930Z" level=info msg="containerd successfully booted in 0.238982s" Jan 29 10:46:24.714131 systemd[1]: Started containerd.service - containerd container runtime. Jan 29 10:46:24.717248 systemd[1]: Started polkit.service - Authorization Manager. Jan 29 10:46:24.729729 sshd_keygen[1864]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jan 29 10:46:24.763104 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO http_proxy: Jan 29 10:46:24.794965 systemd-hostnamed[1874]: Hostname set to (transient) Jan 29 10:46:24.795600 systemd-resolved[1646]: System hostname changed to 'ip-172-31-25-38'. Jan 29 10:46:24.817759 locksmithd[1880]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 29 10:46:24.824515 update-ssh-keys[1992]: Updated "/home/core/.ssh/authorized_keys" Jan 29 10:46:24.829172 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Jan 29 10:46:24.837408 systemd[1]: Finished sshkeys.service. Jan 29 10:46:24.864299 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO no_proxy: Jan 29 10:46:24.904740 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 29 10:46:24.938671 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 29 10:46:24.957309 systemd[1]: Started sshd@0-172.31.25.38:22-139.178.89.65:56292.service - OpenSSH per-connection server daemon (139.178.89.65:56292). Jan 29 10:46:24.973354 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO Checking if agent identity type OnPrem can be assumed Jan 29 10:46:24.992433 systemd[1]: issuegen.service: Deactivated successfully. Jan 29 10:46:24.994157 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 29 10:46:25.009656 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 29 10:46:25.067152 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 29 10:46:25.074203 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO Checking if agent identity type EC2 can be assumed Jan 29 10:46:25.082017 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 29 10:46:25.095713 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jan 29 10:46:25.098438 systemd[1]: Reached target getty.target - Login Prompts. Jan 29 10:46:25.100927 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 29 10:46:25.103801 systemd[1]: Startup finished in 1.238s (kernel) + 7.517s (initrd) + 6.849s (userspace) = 15.604s. Jan 29 10:46:25.153853 agetty[2062]: failed to open credentials directory Jan 29 10:46:25.154180 agetty[2061]: failed to open credentials directory Jan 29 10:46:25.173438 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO Agent will take identity from EC2 Jan 29 10:46:25.272867 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO [amazon-ssm-agent] using named pipe channel for IPC Jan 29 10:46:25.277815 sshd[2044]: Accepted publickey for core from 139.178.89.65 port 56292 ssh2: RSA SHA256:JmvWSq8OQrjuKxgpNsrUVji2I6gJ/9NfV7R8kJq+KKI Jan 29 10:46:25.281652 sshd-session[2044]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:46:25.301359 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 29 10:46:25.314407 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 29 10:46:25.318697 systemd-logind[1837]: New session 1 of user core. Jan 29 10:46:25.350644 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 29 10:46:25.365285 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 29 10:46:25.372631 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO [amazon-ssm-agent] using named pipe channel for IPC Jan 29 10:46:25.376668 (systemd)[2071]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 29 10:46:25.471948 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO [amazon-ssm-agent] using named pipe channel for IPC Jan 29 10:46:25.526024 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Jan 29 10:46:25.526024 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Jan 29 10:46:25.526024 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO [amazon-ssm-agent] Starting Core Agent Jan 29 10:46:25.526024 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO [amazon-ssm-agent] registrar detected. Attempting registration Jan 29 10:46:25.526024 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO [Registrar] Starting registrar module Jan 29 10:46:25.526024 amazon-ssm-agent[1919]: 2025-01-29 10:46:24 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Jan 29 10:46:25.526024 amazon-ssm-agent[1919]: 2025-01-29 10:46:25 INFO [EC2Identity] EC2 registration was successful. Jan 29 10:46:25.526024 amazon-ssm-agent[1919]: 2025-01-29 10:46:25 INFO [CredentialRefresher] credentialRefresher has started Jan 29 10:46:25.526024 amazon-ssm-agent[1919]: 2025-01-29 10:46:25 INFO [CredentialRefresher] Starting credentials refresher loop Jan 29 10:46:25.526024 amazon-ssm-agent[1919]: 2025-01-29 10:46:25 INFO EC2RoleProvider Successfully connected with instance profile role credentials Jan 29 10:46:25.571920 amazon-ssm-agent[1919]: 2025-01-29 10:46:25 INFO [CredentialRefresher] Next credential rotation will be in 32.283324699733335 minutes Jan 29 10:46:25.603083 systemd[2071]: Queued start job for default target default.target. Jan 29 10:46:25.615386 systemd[2071]: Created slice app.slice - User Application Slice. Jan 29 10:46:25.615454 systemd[2071]: Reached target paths.target - Paths. Jan 29 10:46:25.615487 systemd[2071]: Reached target timers.target - Timers. Jan 29 10:46:25.617984 systemd[2071]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 29 10:46:25.647392 systemd[2071]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 29 10:46:25.647946 systemd[2071]: Reached target sockets.target - Sockets. Jan 29 10:46:25.647999 systemd[2071]: Reached target basic.target - Basic System. Jan 29 10:46:25.648174 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 29 10:46:25.649095 systemd[2071]: Reached target default.target - Main User Target. Jan 29 10:46:25.649188 systemd[2071]: Startup finished in 258ms. Jan 29 10:46:25.656302 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 29 10:46:25.812597 systemd[1]: Started sshd@1-172.31.25.38:22-139.178.89.65:56294.service - OpenSSH per-connection server daemon (139.178.89.65:56294). Jan 29 10:46:25.992260 sshd[2083]: Accepted publickey for core from 139.178.89.65 port 56294 ssh2: RSA SHA256:JmvWSq8OQrjuKxgpNsrUVji2I6gJ/9NfV7R8kJq+KKI Jan 29 10:46:25.994676 sshd-session[2083]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:46:26.002541 systemd-logind[1837]: New session 2 of user core. Jan 29 10:46:26.014310 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 29 10:46:26.137875 sshd[2085]: Connection closed by 139.178.89.65 port 56294 Jan 29 10:46:26.137627 sshd-session[2083]: pam_unix(sshd:session): session closed for user core Jan 29 10:46:26.144874 systemd[1]: sshd@1-172.31.25.38:22-139.178.89.65:56294.service: Deactivated successfully. Jan 29 10:46:26.148886 systemd[1]: session-2.scope: Deactivated successfully. Jan 29 10:46:26.150544 systemd-logind[1837]: Session 2 logged out. Waiting for processes to exit. Jan 29 10:46:26.152445 systemd-logind[1837]: Removed session 2. Jan 29 10:46:26.183619 systemd[1]: Started sshd@2-172.31.25.38:22-139.178.89.65:56298.service - OpenSSH per-connection server daemon (139.178.89.65:56298). Jan 29 10:46:26.381620 sshd[2090]: Accepted publickey for core from 139.178.89.65 port 56298 ssh2: RSA SHA256:JmvWSq8OQrjuKxgpNsrUVji2I6gJ/9NfV7R8kJq+KKI Jan 29 10:46:26.384032 sshd-session[2090]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:46:26.392388 systemd-logind[1837]: New session 3 of user core. Jan 29 10:46:26.403378 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 29 10:46:26.524253 sshd[2092]: Connection closed by 139.178.89.65 port 56298 Jan 29 10:46:26.525096 sshd-session[2090]: pam_unix(sshd:session): session closed for user core Jan 29 10:46:26.531148 systemd[1]: sshd@2-172.31.25.38:22-139.178.89.65:56298.service: Deactivated successfully. Jan 29 10:46:26.534818 systemd[1]: session-3.scope: Deactivated successfully. Jan 29 10:46:26.540285 systemd-logind[1837]: Session 3 logged out. Waiting for processes to exit. Jan 29 10:46:26.542662 systemd-logind[1837]: Removed session 3. Jan 29 10:46:26.567896 amazon-ssm-agent[1919]: 2025-01-29 10:46:26 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Jan 29 10:46:26.566518 systemd[1]: Started sshd@3-172.31.25.38:22-139.178.89.65:56312.service - OpenSSH per-connection server daemon (139.178.89.65:56312). Jan 29 10:46:26.666438 amazon-ssm-agent[1919]: 2025-01-29 10:46:26 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2099) started Jan 29 10:46:26.692165 ntpd[1833]: Listen normally on 6 eth0 [fe80::489:edff:fee3:6d9%2]:123 Jan 29 10:46:26.692781 ntpd[1833]: 29 Jan 10:46:26 ntpd[1833]: Listen normally on 6 eth0 [fe80::489:edff:fee3:6d9%2]:123 Jan 29 10:46:26.763106 sshd[2098]: Accepted publickey for core from 139.178.89.65 port 56312 ssh2: RSA SHA256:JmvWSq8OQrjuKxgpNsrUVji2I6gJ/9NfV7R8kJq+KKI Jan 29 10:46:26.765350 sshd-session[2098]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:46:26.766614 amazon-ssm-agent[1919]: 2025-01-29 10:46:26 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Jan 29 10:46:26.774381 systemd-logind[1837]: New session 4 of user core. Jan 29 10:46:26.786355 systemd[1]: Started session-4.scope - Session 4 of User core. Jan 29 10:46:26.912368 sshd[2110]: Connection closed by 139.178.89.65 port 56312 Jan 29 10:46:26.915313 sshd-session[2098]: pam_unix(sshd:session): session closed for user core Jan 29 10:46:26.921318 systemd[1]: sshd@3-172.31.25.38:22-139.178.89.65:56312.service: Deactivated successfully. Jan 29 10:46:26.925031 systemd[1]: session-4.scope: Deactivated successfully. Jan 29 10:46:26.927258 systemd-logind[1837]: Session 4 logged out. Waiting for processes to exit. Jan 29 10:46:26.929014 systemd-logind[1837]: Removed session 4. Jan 29 10:46:26.945979 systemd[1]: Started sshd@4-172.31.25.38:22-139.178.89.65:56318.service - OpenSSH per-connection server daemon (139.178.89.65:56318). Jan 29 10:46:27.136814 sshd[2115]: Accepted publickey for core from 139.178.89.65 port 56318 ssh2: RSA SHA256:JmvWSq8OQrjuKxgpNsrUVji2I6gJ/9NfV7R8kJq+KKI Jan 29 10:46:27.139209 sshd-session[2115]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:46:27.148403 systemd-logind[1837]: New session 5 of user core. Jan 29 10:46:27.155365 systemd[1]: Started session-5.scope - Session 5 of User core. Jan 29 10:46:27.303664 sudo[2118]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jan 29 10:46:27.304294 sudo[2118]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:46:27.321267 sudo[2118]: pam_unix(sudo:session): session closed for user root Jan 29 10:46:27.344408 sshd[2117]: Connection closed by 139.178.89.65 port 56318 Jan 29 10:46:27.344224 sshd-session[2115]: pam_unix(sshd:session): session closed for user core Jan 29 10:46:27.350743 systemd[1]: sshd@4-172.31.25.38:22-139.178.89.65:56318.service: Deactivated successfully. Jan 29 10:46:27.353759 systemd[1]: session-5.scope: Deactivated successfully. Jan 29 10:46:27.355339 systemd-logind[1837]: Session 5 logged out. Waiting for processes to exit. Jan 29 10:46:27.357526 systemd-logind[1837]: Removed session 5. Jan 29 10:46:27.384729 systemd[1]: Started sshd@5-172.31.25.38:22-139.178.89.65:56330.service - OpenSSH per-connection server daemon (139.178.89.65:56330). Jan 29 10:46:27.579907 sshd[2123]: Accepted publickey for core from 139.178.89.65 port 56330 ssh2: RSA SHA256:JmvWSq8OQrjuKxgpNsrUVji2I6gJ/9NfV7R8kJq+KKI Jan 29 10:46:27.582626 sshd-session[2123]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:46:27.591463 systemd-logind[1837]: New session 6 of user core. Jan 29 10:46:27.598306 systemd[1]: Started session-6.scope - Session 6 of User core. Jan 29 10:46:27.703225 sudo[2127]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Jan 29 10:46:27.703848 sudo[2127]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:46:27.709525 sudo[2127]: pam_unix(sudo:session): session closed for user root Jan 29 10:46:27.719120 sudo[2126]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jan 29 10:46:27.720272 sudo[2126]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:46:27.742663 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 10:46:27.796922 augenrules[2149]: No rules Jan 29 10:46:27.799233 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 10:46:27.799595 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 10:46:27.801871 sudo[2126]: pam_unix(sudo:session): session closed for user root Jan 29 10:46:27.825382 sshd[2125]: Connection closed by 139.178.89.65 port 56330 Jan 29 10:46:27.826179 sshd-session[2123]: pam_unix(sshd:session): session closed for user core Jan 29 10:46:27.832171 systemd[1]: sshd@5-172.31.25.38:22-139.178.89.65:56330.service: Deactivated successfully. Jan 29 10:46:27.835563 systemd[1]: session-6.scope: Deactivated successfully. Jan 29 10:46:27.838836 systemd-logind[1837]: Session 6 logged out. Waiting for processes to exit. Jan 29 10:46:27.840751 systemd-logind[1837]: Removed session 6. Jan 29 10:46:27.861025 systemd[1]: Started sshd@6-172.31.25.38:22-139.178.89.65:56340.service - OpenSSH per-connection server daemon (139.178.89.65:56340). Jan 29 10:46:28.056101 sshd[2157]: Accepted publickey for core from 139.178.89.65 port 56340 ssh2: RSA SHA256:JmvWSq8OQrjuKxgpNsrUVji2I6gJ/9NfV7R8kJq+KKI Jan 29 10:46:28.058478 sshd-session[2157]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:46:28.065639 systemd-logind[1837]: New session 7 of user core. Jan 29 10:46:28.075551 systemd[1]: Started session-7.scope - Session 7 of User core. Jan 29 10:46:28.191644 sshd[2159]: Connection closed by 139.178.89.65 port 56340 Jan 29 10:46:28.192427 sshd-session[2157]: pam_unix(sshd:session): session closed for user core Jan 29 10:46:28.197575 systemd-logind[1837]: Session 7 logged out. Waiting for processes to exit. Jan 29 10:46:28.197878 systemd[1]: sshd@6-172.31.25.38:22-139.178.89.65:56340.service: Deactivated successfully. Jan 29 10:46:28.200569 systemd[1]: session-7.scope: Deactivated successfully. Jan 29 10:46:28.203793 systemd-logind[1837]: Removed session 7.