Jan 29 10:55:13.182736 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Jan 29 10:55:13.182781 kernel: Linux version 6.6.74-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Wed Jan 29 09:37:00 -00 2025 Jan 29 10:55:13.182805 kernel: KASLR disabled due to lack of seed Jan 29 10:55:13.182822 kernel: efi: EFI v2.7 by EDK II Jan 29 10:55:13.182839 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b003a98 MEMRESERVE=0x78503d98 Jan 29 10:55:13.182854 kernel: secureboot: Secure boot disabled Jan 29 10:55:13.182871 kernel: ACPI: Early table checksum verification disabled Jan 29 10:55:13.182888 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Jan 29 10:55:13.182904 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Jan 29 10:55:13.182920 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Jan 29 10:55:13.182941 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Jan 29 10:55:13.182958 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Jan 29 10:55:13.182974 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Jan 29 10:55:13.182990 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Jan 29 10:55:13.183010 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Jan 29 10:55:13.183095 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Jan 29 10:55:13.183115 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Jan 29 10:55:13.183132 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Jan 29 10:55:13.183148 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Jan 29 10:55:13.183164 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Jan 29 10:55:13.183181 kernel: printk: bootconsole [uart0] enabled Jan 29 10:55:13.183197 kernel: NUMA: Failed to initialise from firmware Jan 29 10:55:13.183213 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Jan 29 10:55:13.183229 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Jan 29 10:55:13.183245 kernel: Zone ranges: Jan 29 10:55:13.183261 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Jan 29 10:55:13.183281 kernel: DMA32 empty Jan 29 10:55:13.183297 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Jan 29 10:55:13.183313 kernel: Movable zone start for each node Jan 29 10:55:13.183329 kernel: Early memory node ranges Jan 29 10:55:13.183345 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Jan 29 10:55:13.183360 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Jan 29 10:55:13.183376 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Jan 29 10:55:13.183392 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Jan 29 10:55:13.183408 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Jan 29 10:55:13.183424 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Jan 29 10:55:13.183440 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Jan 29 10:55:13.183455 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Jan 29 10:55:13.183475 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Jan 29 10:55:13.183492 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Jan 29 10:55:13.183514 kernel: psci: probing for conduit method from ACPI. Jan 29 10:55:13.183531 kernel: psci: PSCIv1.0 detected in firmware. Jan 29 10:55:13.183548 kernel: psci: Using standard PSCI v0.2 function IDs Jan 29 10:55:13.183568 kernel: psci: Trusted OS migration not required Jan 29 10:55:13.183585 kernel: psci: SMC Calling Convention v1.1 Jan 29 10:55:13.183602 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Jan 29 10:55:13.183619 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Jan 29 10:55:13.183636 kernel: pcpu-alloc: [0] 0 [0] 1 Jan 29 10:55:13.183653 kernel: Detected PIPT I-cache on CPU0 Jan 29 10:55:13.183670 kernel: CPU features: detected: GIC system register CPU interface Jan 29 10:55:13.183687 kernel: CPU features: detected: Spectre-v2 Jan 29 10:55:13.183703 kernel: CPU features: detected: Spectre-v3a Jan 29 10:55:13.183720 kernel: CPU features: detected: Spectre-BHB Jan 29 10:55:13.183736 kernel: CPU features: detected: ARM erratum 1742098 Jan 29 10:55:13.183753 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Jan 29 10:55:13.183795 kernel: alternatives: applying boot alternatives Jan 29 10:55:13.183816 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=c8edc06d36325e34bb125a9ad39c4f788eb9f01102631b71efea3f9afa94c89e Jan 29 10:55:13.183834 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jan 29 10:55:13.183851 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 29 10:55:13.183868 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 29 10:55:13.183885 kernel: Fallback order for Node 0: 0 Jan 29 10:55:13.183902 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Jan 29 10:55:13.183918 kernel: Policy zone: Normal Jan 29 10:55:13.183935 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 29 10:55:13.183952 kernel: software IO TLB: area num 2. Jan 29 10:55:13.183974 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Jan 29 10:55:13.183992 kernel: Memory: 3819960K/4030464K available (10240K kernel code, 2186K rwdata, 8096K rodata, 39680K init, 897K bss, 210504K reserved, 0K cma-reserved) Jan 29 10:55:13.184009 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jan 29 10:55:13.186104 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 29 10:55:13.186136 kernel: rcu: RCU event tracing is enabled. Jan 29 10:55:13.186155 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jan 29 10:55:13.186173 kernel: Trampoline variant of Tasks RCU enabled. Jan 29 10:55:13.186190 kernel: Tracing variant of Tasks RCU enabled. Jan 29 10:55:13.186207 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 29 10:55:13.186224 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jan 29 10:55:13.186241 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 29 10:55:13.186267 kernel: GICv3: 96 SPIs implemented Jan 29 10:55:13.186284 kernel: GICv3: 0 Extended SPIs implemented Jan 29 10:55:13.186301 kernel: Root IRQ handler: gic_handle_irq Jan 29 10:55:13.186318 kernel: GICv3: GICv3 features: 16 PPIs Jan 29 10:55:13.186334 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Jan 29 10:55:13.186351 kernel: ITS [mem 0x10080000-0x1009ffff] Jan 29 10:55:13.186368 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Jan 29 10:55:13.186385 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Jan 29 10:55:13.186402 kernel: GICv3: using LPI property table @0x00000004000d0000 Jan 29 10:55:13.186419 kernel: ITS: Using hypervisor restricted LPI range [128] Jan 29 10:55:13.186435 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Jan 29 10:55:13.186452 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 29 10:55:13.186473 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Jan 29 10:55:13.186491 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Jan 29 10:55:13.186508 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Jan 29 10:55:13.186524 kernel: Console: colour dummy device 80x25 Jan 29 10:55:13.186542 kernel: printk: console [tty1] enabled Jan 29 10:55:13.186560 kernel: ACPI: Core revision 20230628 Jan 29 10:55:13.186577 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Jan 29 10:55:13.186595 kernel: pid_max: default: 32768 minimum: 301 Jan 29 10:55:13.186613 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 29 10:55:13.186630 kernel: landlock: Up and running. Jan 29 10:55:13.186651 kernel: SELinux: Initializing. Jan 29 10:55:13.186668 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 10:55:13.186686 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 10:55:13.186704 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 29 10:55:13.186721 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:55:13.186738 kernel: rcu: Hierarchical SRCU implementation. Jan 29 10:55:13.186755 kernel: rcu: Max phase no-delay instances is 400. Jan 29 10:55:13.186773 kernel: Platform MSI: ITS@0x10080000 domain created Jan 29 10:55:13.186794 kernel: PCI/MSI: ITS@0x10080000 domain created Jan 29 10:55:13.186812 kernel: Remapping and enabling EFI services. Jan 29 10:55:13.186829 kernel: smp: Bringing up secondary CPUs ... Jan 29 10:55:13.186846 kernel: Detected PIPT I-cache on CPU1 Jan 29 10:55:13.186864 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Jan 29 10:55:13.186881 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Jan 29 10:55:13.186898 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Jan 29 10:55:13.186916 kernel: smp: Brought up 1 node, 2 CPUs Jan 29 10:55:13.186933 kernel: SMP: Total of 2 processors activated. Jan 29 10:55:13.186950 kernel: CPU features: detected: 32-bit EL0 Support Jan 29 10:55:13.186974 kernel: CPU features: detected: 32-bit EL1 Support Jan 29 10:55:13.186993 kernel: CPU features: detected: CRC32 instructions Jan 29 10:55:13.187064 kernel: CPU: All CPU(s) started at EL1 Jan 29 10:55:13.187093 kernel: alternatives: applying system-wide alternatives Jan 29 10:55:13.187112 kernel: devtmpfs: initialized Jan 29 10:55:13.187131 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 29 10:55:13.187149 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jan 29 10:55:13.187168 kernel: pinctrl core: initialized pinctrl subsystem Jan 29 10:55:13.187187 kernel: SMBIOS 3.0.0 present. Jan 29 10:55:13.187210 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Jan 29 10:55:13.187228 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 29 10:55:13.187247 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 29 10:55:13.187266 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 29 10:55:13.187285 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 29 10:55:13.187303 kernel: audit: initializing netlink subsys (disabled) Jan 29 10:55:13.187323 kernel: audit: type=2000 audit(0.220:1): state=initialized audit_enabled=0 res=1 Jan 29 10:55:13.187345 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 29 10:55:13.187364 kernel: cpuidle: using governor menu Jan 29 10:55:13.187383 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 29 10:55:13.187402 kernel: ASID allocator initialised with 65536 entries Jan 29 10:55:13.187421 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 29 10:55:13.187439 kernel: Serial: AMBA PL011 UART driver Jan 29 10:55:13.187458 kernel: Modules: 17440 pages in range for non-PLT usage Jan 29 10:55:13.187477 kernel: Modules: 508960 pages in range for PLT usage Jan 29 10:55:13.187495 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 29 10:55:13.187518 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 29 10:55:13.187536 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 29 10:55:13.187554 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 29 10:55:13.187572 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 29 10:55:13.187590 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 29 10:55:13.187608 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 29 10:55:13.187626 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 29 10:55:13.187643 kernel: ACPI: Added _OSI(Module Device) Jan 29 10:55:13.187661 kernel: ACPI: Added _OSI(Processor Device) Jan 29 10:55:13.187683 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jan 29 10:55:13.187701 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 29 10:55:13.187719 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 29 10:55:13.187737 kernel: ACPI: Interpreter enabled Jan 29 10:55:13.187755 kernel: ACPI: Using GIC for interrupt routing Jan 29 10:55:13.187796 kernel: ACPI: MCFG table detected, 1 entries Jan 29 10:55:13.187815 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Jan 29 10:55:13.192227 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jan 29 10:55:13.192472 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jan 29 10:55:13.192666 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jan 29 10:55:13.192867 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Jan 29 10:55:13.193088 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Jan 29 10:55:13.193114 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Jan 29 10:55:13.193133 kernel: acpiphp: Slot [1] registered Jan 29 10:55:13.193152 kernel: acpiphp: Slot [2] registered Jan 29 10:55:13.193170 kernel: acpiphp: Slot [3] registered Jan 29 10:55:13.193194 kernel: acpiphp: Slot [4] registered Jan 29 10:55:13.193212 kernel: acpiphp: Slot [5] registered Jan 29 10:55:13.193230 kernel: acpiphp: Slot [6] registered Jan 29 10:55:13.193248 kernel: acpiphp: Slot [7] registered Jan 29 10:55:13.193266 kernel: acpiphp: Slot [8] registered Jan 29 10:55:13.193284 kernel: acpiphp: Slot [9] registered Jan 29 10:55:13.193302 kernel: acpiphp: Slot [10] registered Jan 29 10:55:13.193320 kernel: acpiphp: Slot [11] registered Jan 29 10:55:13.193338 kernel: acpiphp: Slot [12] registered Jan 29 10:55:13.193356 kernel: acpiphp: Slot [13] registered Jan 29 10:55:13.193378 kernel: acpiphp: Slot [14] registered Jan 29 10:55:13.193395 kernel: acpiphp: Slot [15] registered Jan 29 10:55:13.193413 kernel: acpiphp: Slot [16] registered Jan 29 10:55:13.193431 kernel: acpiphp: Slot [17] registered Jan 29 10:55:13.193449 kernel: acpiphp: Slot [18] registered Jan 29 10:55:13.193466 kernel: acpiphp: Slot [19] registered Jan 29 10:55:13.193484 kernel: acpiphp: Slot [20] registered Jan 29 10:55:13.193502 kernel: acpiphp: Slot [21] registered Jan 29 10:55:13.193519 kernel: acpiphp: Slot [22] registered Jan 29 10:55:13.193541 kernel: acpiphp: Slot [23] registered Jan 29 10:55:13.193559 kernel: acpiphp: Slot [24] registered Jan 29 10:55:13.193577 kernel: acpiphp: Slot [25] registered Jan 29 10:55:13.193595 kernel: acpiphp: Slot [26] registered Jan 29 10:55:13.193613 kernel: acpiphp: Slot [27] registered Jan 29 10:55:13.193630 kernel: acpiphp: Slot [28] registered Jan 29 10:55:13.193648 kernel: acpiphp: Slot [29] registered Jan 29 10:55:13.193666 kernel: acpiphp: Slot [30] registered Jan 29 10:55:13.193684 kernel: acpiphp: Slot [31] registered Jan 29 10:55:13.193702 kernel: PCI host bridge to bus 0000:00 Jan 29 10:55:13.193908 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Jan 29 10:55:13.196227 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jan 29 10:55:13.196442 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Jan 29 10:55:13.196624 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Jan 29 10:55:13.196865 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Jan 29 10:55:13.197116 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Jan 29 10:55:13.197342 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Jan 29 10:55:13.197572 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Jan 29 10:55:13.197777 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Jan 29 10:55:13.197982 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Jan 29 10:55:13.202549 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Jan 29 10:55:13.202814 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Jan 29 10:55:13.203045 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Jan 29 10:55:13.203269 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Jan 29 10:55:13.203468 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Jan 29 10:55:13.203667 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Jan 29 10:55:13.203889 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Jan 29 10:55:13.206223 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Jan 29 10:55:13.206454 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Jan 29 10:55:13.206660 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Jan 29 10:55:13.206853 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Jan 29 10:55:13.207076 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jan 29 10:55:13.207260 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Jan 29 10:55:13.207286 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jan 29 10:55:13.207305 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jan 29 10:55:13.207324 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jan 29 10:55:13.207342 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jan 29 10:55:13.207360 kernel: iommu: Default domain type: Translated Jan 29 10:55:13.207384 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 29 10:55:13.207403 kernel: efivars: Registered efivars operations Jan 29 10:55:13.207421 kernel: vgaarb: loaded Jan 29 10:55:13.207439 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 29 10:55:13.207457 kernel: VFS: Disk quotas dquot_6.6.0 Jan 29 10:55:13.207475 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 29 10:55:13.207493 kernel: pnp: PnP ACPI init Jan 29 10:55:13.207701 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Jan 29 10:55:13.207734 kernel: pnp: PnP ACPI: found 1 devices Jan 29 10:55:13.207753 kernel: NET: Registered PF_INET protocol family Jan 29 10:55:13.207791 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 29 10:55:13.207812 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 29 10:55:13.207830 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 29 10:55:13.207849 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 29 10:55:13.207867 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 29 10:55:13.207886 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 29 10:55:13.207904 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 10:55:13.207929 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 10:55:13.207948 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 29 10:55:13.207968 kernel: PCI: CLS 0 bytes, default 64 Jan 29 10:55:13.207986 kernel: kvm [1]: HYP mode not available Jan 29 10:55:13.208004 kernel: Initialise system trusted keyrings Jan 29 10:55:13.209584 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 29 10:55:13.209617 kernel: Key type asymmetric registered Jan 29 10:55:13.209637 kernel: Asymmetric key parser 'x509' registered Jan 29 10:55:13.209657 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jan 29 10:55:13.209687 kernel: io scheduler mq-deadline registered Jan 29 10:55:13.209708 kernel: io scheduler kyber registered Jan 29 10:55:13.209727 kernel: io scheduler bfq registered Jan 29 10:55:13.210341 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Jan 29 10:55:13.210391 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jan 29 10:55:13.210411 kernel: ACPI: button: Power Button [PWRB] Jan 29 10:55:13.210430 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Jan 29 10:55:13.210449 kernel: ACPI: button: Sleep Button [SLPB] Jan 29 10:55:13.210481 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 29 10:55:13.210501 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Jan 29 10:55:13.210775 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Jan 29 10:55:13.210814 kernel: printk: console [ttyS0] disabled Jan 29 10:55:13.210835 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Jan 29 10:55:13.210855 kernel: printk: console [ttyS0] enabled Jan 29 10:55:13.210874 kernel: printk: bootconsole [uart0] disabled Jan 29 10:55:13.210894 kernel: thunder_xcv, ver 1.0 Jan 29 10:55:13.210914 kernel: thunder_bgx, ver 1.0 Jan 29 10:55:13.210935 kernel: nicpf, ver 1.0 Jan 29 10:55:13.210971 kernel: nicvf, ver 1.0 Jan 29 10:55:13.213610 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 29 10:55:13.213827 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-01-29T10:55:12 UTC (1738148112) Jan 29 10:55:13.213854 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 29 10:55:13.213873 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Jan 29 10:55:13.213893 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jan 29 10:55:13.213912 kernel: watchdog: Hard watchdog permanently disabled Jan 29 10:55:13.213942 kernel: NET: Registered PF_INET6 protocol family Jan 29 10:55:13.213961 kernel: Segment Routing with IPv6 Jan 29 10:55:13.213980 kernel: In-situ OAM (IOAM) with IPv6 Jan 29 10:55:13.213999 kernel: NET: Registered PF_PACKET protocol family Jan 29 10:55:13.214051 kernel: Key type dns_resolver registered Jan 29 10:55:13.214076 kernel: registered taskstats version 1 Jan 29 10:55:13.214095 kernel: Loading compiled-in X.509 certificates Jan 29 10:55:13.214114 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.74-flatcar: f3333311a24aa8c58222f4e98a07eaa1f186ad1a' Jan 29 10:55:13.214132 kernel: Key type .fscrypt registered Jan 29 10:55:13.214150 kernel: Key type fscrypt-provisioning registered Jan 29 10:55:13.214175 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 29 10:55:13.214194 kernel: ima: Allocated hash algorithm: sha1 Jan 29 10:55:13.214212 kernel: ima: No architecture policies found Jan 29 10:55:13.214230 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 29 10:55:13.214250 kernel: clk: Disabling unused clocks Jan 29 10:55:13.214268 kernel: Freeing unused kernel memory: 39680K Jan 29 10:55:13.214287 kernel: Run /init as init process Jan 29 10:55:13.214305 kernel: with arguments: Jan 29 10:55:13.214324 kernel: /init Jan 29 10:55:13.214347 kernel: with environment: Jan 29 10:55:13.214365 kernel: HOME=/ Jan 29 10:55:13.214384 kernel: TERM=linux Jan 29 10:55:13.214402 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jan 29 10:55:13.214426 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:55:13.214450 systemd[1]: Detected virtualization amazon. Jan 29 10:55:13.214471 systemd[1]: Detected architecture arm64. Jan 29 10:55:13.214494 systemd[1]: Running in initrd. Jan 29 10:55:13.214514 systemd[1]: No hostname configured, using default hostname. Jan 29 10:55:13.214534 systemd[1]: Hostname set to . Jan 29 10:55:13.214555 systemd[1]: Initializing machine ID from VM UUID. Jan 29 10:55:13.214574 systemd[1]: Queued start job for default target initrd.target. Jan 29 10:55:13.214594 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 10:55:13.214614 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 10:55:13.214636 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 29 10:55:13.214662 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 10:55:13.214683 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 29 10:55:13.214703 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 29 10:55:13.214730 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:55:13.214750 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 29 10:55:13.214770 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 10:55:13.214790 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 10:55:13.214814 systemd[1]: Reached target paths.target - Path Units. Jan 29 10:55:13.214835 systemd[1]: Reached target slices.target - Slice Units. Jan 29 10:55:13.214855 systemd[1]: Reached target swap.target - Swaps. Jan 29 10:55:13.214874 systemd[1]: Reached target timers.target - Timer Units. Jan 29 10:55:13.214894 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 10:55:13.214914 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 10:55:13.214934 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 29 10:55:13.214954 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 29 10:55:13.214974 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 10:55:13.214999 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 10:55:13.215285 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 10:55:13.216394 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 10:55:13.216441 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 29 10:55:13.216464 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 10:55:13.216486 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 29 10:55:13.216506 systemd[1]: Starting systemd-fsck-usr.service... Jan 29 10:55:13.216527 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 10:55:13.216560 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 10:55:13.216581 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 10:55:13.216601 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 29 10:55:13.216621 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 10:55:13.216700 systemd-journald[252]: Collecting audit messages is disabled. Jan 29 10:55:13.216749 systemd[1]: Finished systemd-fsck-usr.service. Jan 29 10:55:13.216771 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 29 10:55:13.216792 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:55:13.216811 kernel: Bridge firewalling registered Jan 29 10:55:13.216835 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 10:55:13.216855 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 10:55:13.216875 systemd-journald[252]: Journal started Jan 29 10:55:13.216913 systemd-journald[252]: Runtime Journal (/run/log/journal/ec24dfdbdd7d13a4a6cff545642705d0) is 8.0M, max 75.3M, 67.3M free. Jan 29 10:55:13.162957 systemd-modules-load[253]: Inserted module 'overlay' Jan 29 10:55:13.226599 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 10:55:13.199668 systemd-modules-load[253]: Inserted module 'br_netfilter' Jan 29 10:55:13.221648 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 10:55:13.242333 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 10:55:13.248292 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 10:55:13.249449 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 10:55:13.255279 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 10:55:13.302836 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 10:55:13.310690 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 10:55:13.315213 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 10:55:13.341369 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 10:55:13.348240 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 10:55:13.360352 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 29 10:55:13.394090 dracut-cmdline[288]: dracut-dracut-053 Jan 29 10:55:13.399465 dracut-cmdline[288]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=c8edc06d36325e34bb125a9ad39c4f788eb9f01102631b71efea3f9afa94c89e Jan 29 10:55:13.431776 systemd-resolved[286]: Positive Trust Anchors: Jan 29 10:55:13.433585 systemd-resolved[286]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 10:55:13.433650 systemd-resolved[286]: 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:55:13.531062 kernel: SCSI subsystem initialized Jan 29 10:55:13.539058 kernel: Loading iSCSI transport class v2.0-870. Jan 29 10:55:13.551061 kernel: iscsi: registered transport (tcp) Jan 29 10:55:13.573491 kernel: iscsi: registered transport (qla4xxx) Jan 29 10:55:13.573563 kernel: QLogic iSCSI HBA Driver Jan 29 10:55:13.661077 kernel: random: crng init done Jan 29 10:55:13.661542 systemd-resolved[286]: Defaulting to hostname 'linux'. Jan 29 10:55:13.665271 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 10:55:13.669515 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 10:55:13.690419 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 29 10:55:13.709455 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 29 10:55:13.741786 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 29 10:55:13.741859 kernel: device-mapper: uevent: version 1.0.3 Jan 29 10:55:13.741887 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 29 10:55:13.809082 kernel: raid6: neonx8 gen() 6678 MB/s Jan 29 10:55:13.826055 kernel: raid6: neonx4 gen() 6474 MB/s Jan 29 10:55:13.843051 kernel: raid6: neonx2 gen() 5395 MB/s Jan 29 10:55:13.860052 kernel: raid6: neonx1 gen() 3941 MB/s Jan 29 10:55:13.877052 kernel: raid6: int64x8 gen() 3791 MB/s Jan 29 10:55:13.894051 kernel: raid6: int64x4 gen() 3675 MB/s Jan 29 10:55:13.911058 kernel: raid6: int64x2 gen() 3546 MB/s Jan 29 10:55:13.928865 kernel: raid6: int64x1 gen() 2761 MB/s Jan 29 10:55:13.928932 kernel: raid6: using algorithm neonx8 gen() 6678 MB/s Jan 29 10:55:13.946856 kernel: raid6: .... xor() 4869 MB/s, rmw enabled Jan 29 10:55:13.946934 kernel: raid6: using neon recovery algorithm Jan 29 10:55:13.955246 kernel: xor: measuring software checksum speed Jan 29 10:55:13.955303 kernel: 8regs : 10965 MB/sec Jan 29 10:55:13.956352 kernel: 32regs : 11943 MB/sec Jan 29 10:55:13.957538 kernel: arm64_neon : 9579 MB/sec Jan 29 10:55:13.957570 kernel: xor: using function: 32regs (11943 MB/sec) Jan 29 10:55:14.042383 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 29 10:55:14.060673 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 29 10:55:14.070378 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 10:55:14.112092 systemd-udevd[470]: Using default interface naming scheme 'v255'. Jan 29 10:55:14.121437 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 10:55:14.135299 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 29 10:55:14.167914 dracut-pre-trigger[476]: rd.md=0: removing MD RAID activation Jan 29 10:55:14.225078 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 10:55:14.242412 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 10:55:14.354305 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 10:55:14.368278 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 29 10:55:14.404070 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 29 10:55:14.410094 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 10:55:14.427938 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 10:55:14.433461 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 10:55:14.447309 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 29 10:55:14.492116 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 29 10:55:14.554775 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jan 29 10:55:14.554849 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Jan 29 10:55:14.608046 kernel: ena 0000:00:05.0: ENA device version: 0.10 Jan 29 10:55:14.608344 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Jan 29 10:55:14.608611 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:23:26:d4:01:af Jan 29 10:55:14.582950 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 10:55:14.583352 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 10:55:14.586862 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 10:55:14.588929 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 10:55:14.589205 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 10:55:14.591304 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 10:55:14.603706 (udev-worker)[540]: Network interface NamePolicy= disabled on kernel command line. Jan 29 10:55:14.614175 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 10:55:14.651161 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 10:55:14.656078 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Jan 29 10:55:14.657050 kernel: nvme nvme0: pci function 0000:00:04.0 Jan 29 10:55:14.662546 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 10:55:14.671466 kernel: nvme nvme0: 2/0/0 default/read/poll queues Jan 29 10:55:14.678314 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jan 29 10:55:14.678378 kernel: GPT:9289727 != 16777215 Jan 29 10:55:14.678403 kernel: GPT:Alternate GPT header not at the end of the disk. Jan 29 10:55:14.679364 kernel: GPT:9289727 != 16777215 Jan 29 10:55:14.681004 kernel: GPT: Use GNU Parted to correct GPT errors. Jan 29 10:55:14.681053 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jan 29 10:55:14.707433 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 10:55:14.758829 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by (udev-worker) (514) Jan 29 10:55:14.815055 kernel: BTRFS: device fsid b5bc7ecc-f31a-46c7-9582-5efca7819025 devid 1 transid 39 /dev/nvme0n1p3 scanned by (udev-worker) (537) Jan 29 10:55:14.847893 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Jan 29 10:55:14.870089 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Jan 29 10:55:14.902254 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Jan 29 10:55:14.934295 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Jan 29 10:55:14.940241 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Jan 29 10:55:14.955285 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 29 10:55:14.975066 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jan 29 10:55:14.975209 disk-uuid[661]: Primary Header is updated. Jan 29 10:55:14.975209 disk-uuid[661]: Secondary Entries is updated. Jan 29 10:55:14.975209 disk-uuid[661]: Secondary Header is updated. Jan 29 10:55:15.999061 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jan 29 10:55:16.001511 disk-uuid[663]: The operation has completed successfully. Jan 29 10:55:16.179834 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 29 10:55:16.180083 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 29 10:55:16.231269 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 29 10:55:16.238978 sh[923]: Success Jan 29 10:55:16.262060 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jan 29 10:55:16.371053 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 29 10:55:16.384238 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 29 10:55:16.402260 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 29 10:55:16.434367 kernel: BTRFS info (device dm-0): first mount of filesystem b5bc7ecc-f31a-46c7-9582-5efca7819025 Jan 29 10:55:16.434432 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 29 10:55:16.434457 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 29 10:55:16.435715 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 29 10:55:16.436841 kernel: BTRFS info (device dm-0): using free space tree Jan 29 10:55:16.520055 kernel: BTRFS info (device dm-0): enabling ssd optimizations Jan 29 10:55:16.542173 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 29 10:55:16.545937 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 29 10:55:16.557280 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 29 10:55:16.569300 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 29 10:55:16.595329 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 10:55:16.595390 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jan 29 10:55:16.597128 kernel: BTRFS info (device nvme0n1p6): using free space tree Jan 29 10:55:16.604065 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jan 29 10:55:16.622659 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 29 10:55:16.626009 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 10:55:16.635894 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 29 10:55:16.658873 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 29 10:55:16.754064 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 29 10:55:16.779437 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 10:55:16.840530 systemd-networkd[1115]: lo: Link UP Jan 29 10:55:16.840545 systemd-networkd[1115]: lo: Gained carrier Jan 29 10:55:16.843426 systemd-networkd[1115]: Enumeration completed Jan 29 10:55:16.844208 systemd-networkd[1115]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 10:55:16.844215 systemd-networkd[1115]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 10:55:16.844961 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 10:55:16.860110 systemd[1]: Reached target network.target - Network. Jan 29 10:55:16.869625 systemd-networkd[1115]: eth0: Link UP Jan 29 10:55:16.869638 systemd-networkd[1115]: eth0: Gained carrier Jan 29 10:55:16.869657 systemd-networkd[1115]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 10:55:16.894120 systemd-networkd[1115]: eth0: DHCPv4 address 172.31.29.188/20, gateway 172.31.16.1 acquired from 172.31.16.1 Jan 29 10:55:17.048140 ignition[1038]: Ignition 2.20.0 Jan 29 10:55:17.048169 ignition[1038]: Stage: fetch-offline Jan 29 10:55:17.048613 ignition[1038]: no configs at "/usr/lib/ignition/base.d" Jan 29 10:55:17.048639 ignition[1038]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:55:17.051257 ignition[1038]: Ignition finished successfully Jan 29 10:55:17.057964 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 29 10:55:17.074432 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jan 29 10:55:17.097950 ignition[1126]: Ignition 2.20.0 Jan 29 10:55:17.097972 ignition[1126]: Stage: fetch Jan 29 10:55:17.099242 ignition[1126]: no configs at "/usr/lib/ignition/base.d" Jan 29 10:55:17.099562 ignition[1126]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:55:17.099751 ignition[1126]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:55:17.135923 ignition[1126]: PUT result: OK Jan 29 10:55:17.140150 ignition[1126]: parsed url from cmdline: "" Jan 29 10:55:17.140166 ignition[1126]: no config URL provided Jan 29 10:55:17.140181 ignition[1126]: reading system config file "/usr/lib/ignition/user.ign" Jan 29 10:55:17.140206 ignition[1126]: no config at "/usr/lib/ignition/user.ign" Jan 29 10:55:17.140237 ignition[1126]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:55:17.144746 ignition[1126]: PUT result: OK Jan 29 10:55:17.145671 ignition[1126]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Jan 29 10:55:17.151391 ignition[1126]: GET result: OK Jan 29 10:55:17.151489 ignition[1126]: parsing config with SHA512: 0cb245fb4a91d7585458bc559ea9c5a7a1949d3eba70001d20f3b1d389caf5d59dffc4ae26988fdc8f3b6d5cd54e5165d1b4872d25eba087d7e8db62dbcd98be Jan 29 10:55:17.158974 unknown[1126]: fetched base config from "system" Jan 29 10:55:17.158996 unknown[1126]: fetched base config from "system" Jan 29 10:55:17.160300 ignition[1126]: fetch: fetch complete Jan 29 10:55:17.159010 unknown[1126]: fetched user config from "aws" Jan 29 10:55:17.160313 ignition[1126]: fetch: fetch passed Jan 29 10:55:17.167209 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jan 29 10:55:17.160398 ignition[1126]: Ignition finished successfully Jan 29 10:55:17.182446 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 29 10:55:17.209224 ignition[1132]: Ignition 2.20.0 Jan 29 10:55:17.209252 ignition[1132]: Stage: kargs Jan 29 10:55:17.210483 ignition[1132]: no configs at "/usr/lib/ignition/base.d" Jan 29 10:55:17.210784 ignition[1132]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:55:17.210956 ignition[1132]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:55:17.214198 ignition[1132]: PUT result: OK Jan 29 10:55:17.222136 ignition[1132]: kargs: kargs passed Jan 29 10:55:17.222231 ignition[1132]: Ignition finished successfully Jan 29 10:55:17.226661 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 29 10:55:17.236333 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 29 10:55:17.270859 ignition[1139]: Ignition 2.20.0 Jan 29 10:55:17.271381 ignition[1139]: Stage: disks Jan 29 10:55:17.271987 ignition[1139]: no configs at "/usr/lib/ignition/base.d" Jan 29 10:55:17.272012 ignition[1139]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:55:17.272225 ignition[1139]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:55:17.276183 ignition[1139]: PUT result: OK Jan 29 10:55:17.284445 ignition[1139]: disks: disks passed Jan 29 10:55:17.284540 ignition[1139]: Ignition finished successfully Jan 29 10:55:17.290102 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 29 10:55:17.292503 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 29 10:55:17.296209 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 29 10:55:17.298388 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 10:55:17.300173 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 10:55:17.301975 systemd[1]: Reached target basic.target - Basic System. Jan 29 10:55:17.320309 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 29 10:55:17.362063 systemd-fsck[1147]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jan 29 10:55:17.368374 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 29 10:55:17.381354 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 29 10:55:17.471049 kernel: EXT4-fs (nvme0n1p9): mounted filesystem bd47c032-97f4-4b3a-b174-3601de374086 r/w with ordered data mode. Quota mode: none. Jan 29 10:55:17.471708 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 29 10:55:17.475792 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 29 10:55:17.492324 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 10:55:17.499190 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 29 10:55:17.502914 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jan 29 10:55:17.502998 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:55:17.503154 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 29 10:55:17.524065 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by mount (1166) Jan 29 10:55:17.529063 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 10:55:17.529131 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jan 29 10:55:17.529157 kernel: BTRFS info (device nvme0n1p6): using free space tree Jan 29 10:55:17.536058 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jan 29 10:55:17.538719 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 10:55:17.539307 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 29 10:55:17.550297 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 29 10:55:17.900202 systemd-networkd[1115]: eth0: Gained IPv6LL Jan 29 10:55:17.970644 initrd-setup-root[1190]: cut: /sysroot/etc/passwd: No such file or directory Jan 29 10:55:17.989800 initrd-setup-root[1197]: cut: /sysroot/etc/group: No such file or directory Jan 29 10:55:17.997847 initrd-setup-root[1204]: cut: /sysroot/etc/shadow: No such file or directory Jan 29 10:55:18.005936 initrd-setup-root[1211]: cut: /sysroot/etc/gshadow: No such file or directory Jan 29 10:55:18.288695 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 29 10:55:18.304302 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 29 10:55:18.311329 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 29 10:55:18.328071 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 10:55:18.328777 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 29 10:55:18.372773 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 29 10:55:18.376629 ignition[1279]: INFO : Ignition 2.20.0 Jan 29 10:55:18.376629 ignition[1279]: INFO : Stage: mount Jan 29 10:55:18.380592 ignition[1279]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 10:55:18.380592 ignition[1279]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:55:18.380592 ignition[1279]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:55:18.387665 ignition[1279]: INFO : PUT result: OK Jan 29 10:55:18.392129 ignition[1279]: INFO : mount: mount passed Jan 29 10:55:18.392129 ignition[1279]: INFO : Ignition finished successfully Jan 29 10:55:18.397107 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 29 10:55:18.409184 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 29 10:55:18.482709 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 10:55:18.506059 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/nvme0n1p6 scanned by mount (1290) Jan 29 10:55:18.511441 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 10:55:18.511491 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jan 29 10:55:18.511517 kernel: BTRFS info (device nvme0n1p6): using free space tree Jan 29 10:55:18.517040 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jan 29 10:55:18.520378 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 10:55:18.564706 ignition[1307]: INFO : Ignition 2.20.0 Jan 29 10:55:18.564706 ignition[1307]: INFO : Stage: files Jan 29 10:55:18.567858 ignition[1307]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 10:55:18.567858 ignition[1307]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:55:18.571941 ignition[1307]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:55:18.574920 ignition[1307]: INFO : PUT result: OK Jan 29 10:55:18.579264 ignition[1307]: DEBUG : files: compiled without relabeling support, skipping Jan 29 10:55:18.581556 ignition[1307]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 29 10:55:18.581556 ignition[1307]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 29 10:55:18.610138 ignition[1307]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 29 10:55:18.612674 ignition[1307]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 29 10:55:18.612674 ignition[1307]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 29 10:55:18.611842 unknown[1307]: wrote ssh authorized keys file for user: core Jan 29 10:55:18.624169 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jan 29 10:55:18.627929 ignition[1307]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jan 29 10:55:18.627929 ignition[1307]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 29 10:55:18.635454 ignition[1307]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 29 10:55:18.635454 ignition[1307]: INFO : files: files passed Jan 29 10:55:18.635454 ignition[1307]: INFO : Ignition finished successfully Jan 29 10:55:18.633725 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 29 10:55:18.650482 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 29 10:55:18.657183 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 29 10:55:18.665646 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 29 10:55:18.667837 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 29 10:55:18.693113 initrd-setup-root-after-ignition[1336]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 10:55:18.697936 initrd-setup-root-after-ignition[1336]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 29 10:55:18.700941 initrd-setup-root-after-ignition[1340]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 10:55:18.705266 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 10:55:18.710772 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 29 10:55:18.722398 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 29 10:55:18.781311 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 29 10:55:18.782127 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 29 10:55:18.786346 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 29 10:55:18.792116 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 29 10:55:18.794044 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 29 10:55:18.808296 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 29 10:55:18.837078 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 10:55:18.848455 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 29 10:55:18.873339 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 29 10:55:18.877726 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 10:55:18.880101 systemd[1]: Stopped target timers.target - Timer Units. Jan 29 10:55:18.881939 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 29 10:55:18.882192 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 10:55:18.892175 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 29 10:55:18.894217 systemd[1]: Stopped target basic.target - Basic System. Jan 29 10:55:18.896099 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 29 10:55:18.898257 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 29 10:55:18.900524 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 29 10:55:18.902767 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 29 10:55:18.904828 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 10:55:18.907259 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 29 10:55:18.909323 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 29 10:55:18.911333 systemd[1]: Stopped target swap.target - Swaps. Jan 29 10:55:18.912972 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 29 10:55:18.913212 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 29 10:55:18.915654 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 29 10:55:18.941594 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 10:55:18.943917 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 29 10:55:18.948443 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 10:55:18.950825 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 29 10:55:18.951076 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 29 10:55:18.953505 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 29 10:55:18.953746 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 10:55:18.966203 systemd[1]: ignition-files.service: Deactivated successfully. Jan 29 10:55:18.966407 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 29 10:55:18.975375 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 29 10:55:18.988289 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 29 10:55:18.989930 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 29 10:55:18.990217 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 10:55:18.994456 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 29 10:55:18.994685 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 10:55:19.022487 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 29 10:55:19.027393 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 29 10:55:19.032761 ignition[1360]: INFO : Ignition 2.20.0 Jan 29 10:55:19.032761 ignition[1360]: INFO : Stage: umount Jan 29 10:55:19.032761 ignition[1360]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 10:55:19.032761 ignition[1360]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jan 29 10:55:19.032761 ignition[1360]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jan 29 10:55:19.032761 ignition[1360]: INFO : PUT result: OK Jan 29 10:55:19.057131 ignition[1360]: INFO : umount: umount passed Jan 29 10:55:19.058795 ignition[1360]: INFO : Ignition finished successfully Jan 29 10:55:19.062720 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 29 10:55:19.062975 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 29 10:55:19.069294 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 29 10:55:19.069392 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 29 10:55:19.073167 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 29 10:55:19.073264 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 29 10:55:19.076470 systemd[1]: ignition-fetch.service: Deactivated successfully. Jan 29 10:55:19.076559 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jan 29 10:55:19.095908 systemd[1]: Stopped target network.target - Network. Jan 29 10:55:19.101874 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 29 10:55:19.103566 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 29 10:55:19.113792 systemd[1]: Stopped target paths.target - Path Units. Jan 29 10:55:19.115395 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 29 10:55:19.121378 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 10:55:19.123597 systemd[1]: Stopped target slices.target - Slice Units. Jan 29 10:55:19.125219 systemd[1]: Stopped target sockets.target - Socket Units. Jan 29 10:55:19.126986 systemd[1]: iscsid.socket: Deactivated successfully. Jan 29 10:55:19.127084 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 10:55:19.128898 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 29 10:55:19.128964 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 10:55:19.130793 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 29 10:55:19.130877 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 29 10:55:19.132707 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 29 10:55:19.132784 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 29 10:55:19.135093 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 29 10:55:19.156111 systemd-networkd[1115]: eth0: DHCPv6 lease lost Jan 29 10:55:19.160292 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 29 10:55:19.165962 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 29 10:55:19.168694 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 29 10:55:19.168918 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 29 10:55:19.175790 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 29 10:55:19.177770 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 29 10:55:19.184142 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 29 10:55:19.184380 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 29 10:55:19.188902 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 29 10:55:19.189042 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 29 10:55:19.192491 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 29 10:55:19.192598 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 29 10:55:19.212205 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 29 10:55:19.215439 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 29 10:55:19.215550 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 29 10:55:19.218188 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 29 10:55:19.218267 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 29 10:55:19.220531 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 29 10:55:19.220608 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 29 10:55:19.223138 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 29 10:55:19.223221 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 10:55:19.225916 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 10:55:19.271322 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 29 10:55:19.273144 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 10:55:19.277109 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 29 10:55:19.277198 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 29 10:55:19.279239 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 29 10:55:19.279595 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 10:55:19.283306 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 29 10:55:19.283395 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 29 10:55:19.285530 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 29 10:55:19.285608 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 29 10:55:19.287652 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 10:55:19.287748 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 10:55:19.293288 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 29 10:55:19.295347 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 29 10:55:19.295477 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 10:55:19.297855 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jan 29 10:55:19.297959 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 10:55:19.300292 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 29 10:55:19.300392 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 10:55:19.302713 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 10:55:19.303097 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 10:55:19.319298 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 29 10:55:19.319490 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 29 10:55:19.330462 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 29 10:55:19.330715 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 29 10:55:19.335647 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 29 10:55:19.368345 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 29 10:55:19.396343 systemd[1]: Switching root. Jan 29 10:55:19.452352 systemd-journald[252]: Journal stopped Jan 29 10:55:21.806398 systemd-journald[252]: Received SIGTERM from PID 1 (systemd). Jan 29 10:55:21.806524 kernel: SELinux: policy capability network_peer_controls=1 Jan 29 10:55:21.806571 kernel: SELinux: policy capability open_perms=1 Jan 29 10:55:21.806601 kernel: SELinux: policy capability extended_socket_class=1 Jan 29 10:55:21.806630 kernel: SELinux: policy capability always_check_network=0 Jan 29 10:55:21.806659 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 29 10:55:21.806688 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 29 10:55:21.806725 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 29 10:55:21.806755 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 29 10:55:21.806781 kernel: audit: type=1403 audit(1738148119.934:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 29 10:55:21.806816 systemd[1]: Successfully loaded SELinux policy in 60.815ms. Jan 29 10:55:21.806865 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 22.902ms. Jan 29 10:55:21.806904 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:55:21.806935 systemd[1]: Detected virtualization amazon. Jan 29 10:55:21.806965 systemd[1]: Detected architecture arm64. Jan 29 10:55:21.806994 systemd[1]: Detected first boot. Jan 29 10:55:21.813812 systemd[1]: Initializing machine ID from VM UUID. Jan 29 10:55:21.813882 zram_generator::config[1403]: No configuration found. Jan 29 10:55:21.813921 systemd[1]: Populated /etc with preset unit settings. Jan 29 10:55:21.813959 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 29 10:55:21.813993 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 29 10:55:21.816067 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 29 10:55:21.816134 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 29 10:55:21.816170 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 29 10:55:21.816205 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 29 10:55:21.816235 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 29 10:55:21.816278 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 29 10:55:21.816312 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 29 10:55:21.816341 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 29 10:55:21.816373 systemd[1]: Created slice user.slice - User and Session Slice. Jan 29 10:55:21.816404 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 10:55:21.816433 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 10:55:21.816464 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 29 10:55:21.816499 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 29 10:55:21.816529 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 29 10:55:21.816558 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 10:55:21.816589 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jan 29 10:55:21.816621 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 10:55:21.816650 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 29 10:55:21.816678 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 29 10:55:21.816707 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 29 10:55:21.816742 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 29 10:55:21.816774 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 10:55:21.816805 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 10:55:21.816838 systemd[1]: Reached target slices.target - Slice Units. Jan 29 10:55:21.816867 systemd[1]: Reached target swap.target - Swaps. Jan 29 10:55:21.816898 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 29 10:55:21.816930 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 29 10:55:21.816963 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 10:55:21.816992 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 10:55:21.821918 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 10:55:21.821977 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 29 10:55:21.822010 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 29 10:55:21.822062 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 29 10:55:21.822093 systemd[1]: Mounting media.mount - External Media Directory... Jan 29 10:55:21.822125 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 29 10:55:21.822156 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 29 10:55:21.822185 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 29 10:55:21.822215 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:55:21.822261 systemd[1]: Reached target machines.target - Containers. Jan 29 10:55:21.822290 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 29 10:55:21.822321 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 10:55:21.822353 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 10:55:21.822382 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 29 10:55:21.822410 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 10:55:21.822444 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 10:55:21.822475 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 10:55:21.822508 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 29 10:55:21.822538 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 10:55:21.822567 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 29 10:55:21.822598 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 29 10:55:21.822629 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 29 10:55:21.822658 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 29 10:55:21.822688 systemd[1]: Stopped systemd-fsck-usr.service. Jan 29 10:55:21.822717 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 10:55:21.822745 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 10:55:21.822778 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 29 10:55:21.822807 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 29 10:55:21.822835 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 10:55:21.822882 systemd[1]: verity-setup.service: Deactivated successfully. Jan 29 10:55:21.822913 systemd[1]: Stopped verity-setup.service. Jan 29 10:55:21.822941 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 29 10:55:21.822970 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 29 10:55:21.823000 systemd[1]: Mounted media.mount - External Media Directory. Jan 29 10:55:21.829143 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 29 10:55:21.829224 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 29 10:55:21.829261 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 29 10:55:21.829294 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 10:55:21.829325 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 29 10:55:21.829354 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 29 10:55:21.829387 kernel: fuse: init (API version 7.39) Jan 29 10:55:21.829416 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 10:55:21.829446 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 10:55:21.829475 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 10:55:21.829504 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 10:55:21.829533 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 29 10:55:21.829562 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 29 10:55:21.829594 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 29 10:55:21.829630 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 29 10:55:21.829663 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 29 10:55:21.829737 systemd-journald[1488]: Collecting audit messages is disabled. Jan 29 10:55:21.829791 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 29 10:55:21.829826 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 29 10:55:21.829856 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 29 10:55:21.829885 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 10:55:21.829915 kernel: loop: module loaded Jan 29 10:55:21.829944 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jan 29 10:55:21.829973 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 29 10:55:21.830001 systemd-journald[1488]: Journal started Jan 29 10:55:21.832045 systemd-journald[1488]: Runtime Journal (/run/log/journal/ec24dfdbdd7d13a4a6cff545642705d0) is 8.0M, max 75.3M, 67.3M free. Jan 29 10:55:21.832143 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 29 10:55:21.189921 systemd[1]: Queued start job for default target multi-user.target. Jan 29 10:55:21.258767 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Jan 29 10:55:21.259600 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 29 10:55:21.837851 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 10:55:21.861081 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 29 10:55:21.861173 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 10:55:21.862204 kernel: ACPI: bus type drm_connector registered Jan 29 10:55:21.875868 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 29 10:55:21.884061 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 29 10:55:21.895052 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 29 10:55:21.903105 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 10:55:21.902952 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 10:55:21.903722 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 10:55:21.906837 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 10:55:21.907161 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 10:55:21.909761 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 10:55:21.924579 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 29 10:55:21.927432 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 29 10:55:21.931710 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 29 10:55:21.983185 kernel: loop0: detected capacity change from 0 to 113536 Jan 29 10:55:21.986554 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 29 10:55:22.026346 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 29 10:55:22.028675 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 10:55:22.045600 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 10:55:22.049683 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 29 10:55:22.056547 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jan 29 10:55:22.076721 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jan 29 10:55:22.102607 systemd-tmpfiles[1513]: ACLs are not supported, ignoring. Jan 29 10:55:22.102639 systemd-tmpfiles[1513]: ACLs are not supported, ignoring. Jan 29 10:55:22.117392 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 29 10:55:22.117680 systemd-journald[1488]: Time spent on flushing to /var/log/journal/ec24dfdbdd7d13a4a6cff545642705d0 is 116.197ms for 890 entries. Jan 29 10:55:22.117680 systemd-journald[1488]: System Journal (/var/log/journal/ec24dfdbdd7d13a4a6cff545642705d0) is 8.0M, max 195.6M, 187.6M free. Jan 29 10:55:22.255587 systemd-journald[1488]: Received client request to flush runtime journal. Jan 29 10:55:22.255711 kernel: loop1: detected capacity change from 0 to 116808 Jan 29 10:55:22.148920 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 10:55:22.162535 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 29 10:55:22.196835 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 10:55:22.214443 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jan 29 10:55:22.225825 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 10:55:22.264450 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 29 10:55:22.269520 udevadm[1548]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jan 29 10:55:22.297378 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 29 10:55:22.299250 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jan 29 10:55:22.309080 kernel: loop2: detected capacity change from 0 to 53784 Jan 29 10:55:22.344809 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 29 10:55:22.357344 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 10:55:22.365094 kernel: loop3: detected capacity change from 0 to 113536 Jan 29 10:55:22.386437 kernel: loop4: detected capacity change from 0 to 116808 Jan 29 10:55:22.404204 kernel: loop5: detected capacity change from 0 to 53784 Jan 29 10:55:22.429916 systemd-tmpfiles[1558]: ACLs are not supported, ignoring. Jan 29 10:55:22.429948 systemd-tmpfiles[1558]: ACLs are not supported, ignoring. Jan 29 10:55:22.439908 (sd-merge)[1559]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Jan 29 10:55:22.442015 (sd-merge)[1559]: Merged extensions into '/usr'. Jan 29 10:55:22.449661 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 29 10:55:22.455911 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 10:55:22.468533 systemd[1]: Starting ensure-sysext.service... Jan 29 10:55:22.481381 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 10:55:22.510271 systemd[1]: Reloading requested from client PID 1563 ('systemctl') (unit ensure-sysext.service)... Jan 29 10:55:22.510304 systemd[1]: Reloading... Jan 29 10:55:22.577896 systemd-tmpfiles[1564]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 29 10:55:22.578722 systemd-tmpfiles[1564]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 29 10:55:22.580624 systemd-tmpfiles[1564]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 29 10:55:22.581254 systemd-tmpfiles[1564]: ACLs are not supported, ignoring. Jan 29 10:55:22.581410 systemd-tmpfiles[1564]: ACLs are not supported, ignoring. Jan 29 10:55:22.593344 systemd-tmpfiles[1564]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 10:55:22.593370 systemd-tmpfiles[1564]: Skipping /boot Jan 29 10:55:22.664546 systemd-tmpfiles[1564]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 10:55:22.664579 systemd-tmpfiles[1564]: Skipping /boot Jan 29 10:55:22.693341 zram_generator::config[1592]: No configuration found. Jan 29 10:55:23.031524 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:55:23.141074 systemd[1]: Reloading finished in 630 ms. Jan 29 10:55:23.197096 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 10:55:23.226391 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 10:55:23.239908 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 29 10:55:23.247600 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 29 10:55:23.258579 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 10:55:23.269457 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 29 10:55:23.281161 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 10:55:23.286555 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 10:55:23.294445 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 10:55:23.301519 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 10:55:23.303603 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 10:55:23.311844 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 10:55:23.313444 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 10:55:23.323828 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 10:55:23.338835 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 10:55:23.340966 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 10:55:23.341402 systemd[1]: Reached target time-set.target - System Time Set. Jan 29 10:55:23.354277 systemd[1]: Finished ensure-sysext.service. Jan 29 10:55:23.365541 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 29 10:55:23.384866 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 29 10:55:23.417938 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 10:55:23.420108 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 10:55:23.437588 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 10:55:23.440203 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 10:55:23.443521 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 29 10:55:23.446488 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 10:55:23.463828 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 10:55:23.467161 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 10:55:23.470000 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 10:55:23.470474 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 10:55:23.473327 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 10:55:23.546354 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 29 10:55:23.585872 augenrules[1685]: No rules Jan 29 10:55:23.589650 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 29 10:55:23.592890 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 10:55:23.595388 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 10:55:23.599802 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:55:23.645113 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 29 10:55:23.656398 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 10:55:23.725284 systemd-udevd[1694]: Using default interface naming scheme 'v255'. Jan 29 10:55:23.733149 systemd-resolved[1648]: Positive Trust Anchors: Jan 29 10:55:23.733670 systemd-resolved[1648]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 10:55:23.733739 systemd-resolved[1648]: 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:55:23.742943 systemd-resolved[1648]: Defaulting to hostname 'linux'. Jan 29 10:55:23.745997 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 10:55:23.749252 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 10:55:23.770470 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 10:55:23.781453 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 10:55:23.827128 ldconfig[1507]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 29 10:55:23.843481 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 29 10:55:23.858396 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 29 10:55:23.916432 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 29 10:55:23.942504 systemd-networkd[1696]: lo: Link UP Jan 29 10:55:23.942986 systemd-networkd[1696]: lo: Gained carrier Jan 29 10:55:23.944488 systemd-networkd[1696]: Enumeration completed Jan 29 10:55:23.944811 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 10:55:23.947031 systemd[1]: Reached target network.target - Network. Jan 29 10:55:23.964970 (udev-worker)[1710]: Network interface NamePolicy= disabled on kernel command line. Jan 29 10:55:23.969522 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 29 10:55:24.031586 systemd-networkd[1696]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 10:55:24.031749 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jan 29 10:55:24.032185 systemd-networkd[1696]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 10:55:24.035762 systemd-networkd[1696]: eth0: Link UP Jan 29 10:55:24.036247 systemd-networkd[1696]: eth0: Gained carrier Jan 29 10:55:24.036280 systemd-networkd[1696]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 10:55:24.045078 systemd-networkd[1696]: eth0: DHCPv4 address 172.31.29.188/20, gateway 172.31.16.1 acquired from 172.31.16.1 Jan 29 10:55:24.199085 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 39 scanned by (udev-worker) (1708) Jan 29 10:55:24.204578 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 10:55:24.387055 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Jan 29 10:55:24.396337 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 29 10:55:24.398780 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jan 29 10:55:24.414467 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jan 29 10:55:24.417288 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 10:55:24.445056 lvm[1821]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 10:55:24.462115 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 29 10:55:24.490598 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jan 29 10:55:24.493480 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 10:55:24.495620 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 10:55:24.497803 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 29 10:55:24.500193 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:55:24.502821 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 29 10:55:24.505102 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 29 10:55:24.507397 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 29 10:55:24.509682 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 29 10:55:24.509748 systemd[1]: Reached target paths.target - Path Units. Jan 29 10:55:24.511411 systemd[1]: Reached target timers.target - Timer Units. Jan 29 10:55:24.514542 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 29 10:55:24.518833 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 29 10:55:24.531179 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 29 10:55:24.539447 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jan 29 10:55:24.542800 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 29 10:55:24.545303 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 10:55:24.547367 systemd[1]: Reached target basic.target - Basic System. Jan 29 10:55:24.549992 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 29 10:55:24.550071 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 29 10:55:24.564279 systemd[1]: Starting containerd.service - containerd container runtime... Jan 29 10:55:24.570226 lvm[1828]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 10:55:24.579427 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jan 29 10:55:24.587338 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 29 10:55:24.600341 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 29 10:55:24.605512 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 29 10:55:24.607991 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:55:24.617687 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 29 10:55:24.624375 systemd[1]: Started ntpd.service - Network Time Service. Jan 29 10:55:24.633826 jq[1832]: false Jan 29 10:55:24.641412 systemd[1]: Starting setup-oem.service - Setup OEM... Jan 29 10:55:24.648241 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 29 10:55:24.654609 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 29 10:55:24.688348 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 29 10:55:24.691274 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jan 29 10:55:24.693303 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 29 10:55:24.696134 systemd[1]: Starting update-engine.service - Update Engine... Jan 29 10:55:24.704716 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 29 10:55:24.711160 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jan 29 10:55:24.725957 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 29 10:55:24.727245 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 29 10:55:24.757763 extend-filesystems[1833]: Found loop3 Jan 29 10:55:24.762392 extend-filesystems[1833]: Found loop4 Jan 29 10:55:24.762392 extend-filesystems[1833]: Found loop5 Jan 29 10:55:24.762392 extend-filesystems[1833]: Found nvme0n1 Jan 29 10:55:24.762392 extend-filesystems[1833]: Found nvme0n1p1 Jan 29 10:55:24.762392 extend-filesystems[1833]: Found nvme0n1p2 Jan 29 10:55:24.762392 extend-filesystems[1833]: Found nvme0n1p3 Jan 29 10:55:24.762392 extend-filesystems[1833]: Found usr Jan 29 10:55:24.762392 extend-filesystems[1833]: Found nvme0n1p4 Jan 29 10:55:24.762392 extend-filesystems[1833]: Found nvme0n1p6 Jan 29 10:55:24.762392 extend-filesystems[1833]: Found nvme0n1p7 Jan 29 10:55:24.762392 extend-filesystems[1833]: Found nvme0n1p9 Jan 29 10:55:24.762392 extend-filesystems[1833]: Checking size of /dev/nvme0n1p9 Jan 29 10:55:24.811789 dbus-daemon[1831]: [system] SELinux support is enabled Jan 29 10:55:24.812127 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 29 10:55:24.830210 dbus-daemon[1831]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1696 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Jan 29 10:55:24.829653 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 29 10:55:24.831209 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 29 10:55:24.846581 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:55:24.846663 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 29 10:55:24.850284 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:55:24.850345 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 29 10:55:24.856192 dbus-daemon[1831]: [system] Successfully activated service 'org.freedesktop.systemd1' Jan 29 10:55:24.867460 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Jan 29 10:55:24.870346 (ntainerd)[1859]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 29 10:55:24.881528 jq[1843]: true Jan 29 10:55:24.884945 ntpd[1835]: ntpd 4.2.8p17@1.4004-o Wed Jan 29 09:04:55 UTC 2025 (1): Starting Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: ntpd 4.2.8p17@1.4004-o Wed Jan 29 09:04:55 UTC 2025 (1): Starting Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: ---------------------------------------------------- Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: ntp-4 is maintained by Network Time Foundation, Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: corporation. Support and training for ntp-4 are Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: available at https://www.nwtime.org/support Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: ---------------------------------------------------- Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: proto: precision = 0.096 usec (-23) Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: basedate set to 2025-01-17 Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: gps base set to 2025-01-19 (week 2350) Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: Listen and drop on 0 v6wildcard [::]:123 Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: Listen normally on 2 lo 127.0.0.1:123 Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: Listen normally on 3 eth0 172.31.29.188:123 Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: Listen normally on 4 lo [::1]:123 Jan 29 10:55:24.911270 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: bind(21) AF_INET6 fe80::423:26ff:fed4:1af%2#123 flags 0x11 failed: Cannot assign requested address Jan 29 10:55:24.885006 ntpd[1835]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Jan 29 10:55:24.885086 ntpd[1835]: ---------------------------------------------------- Jan 29 10:55:24.885108 ntpd[1835]: ntp-4 is maintained by Network Time Foundation, Jan 29 10:55:24.885128 ntpd[1835]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Jan 29 10:55:24.885146 ntpd[1835]: corporation. Support and training for ntp-4 are Jan 29 10:55:24.922543 systemd-logind[1839]: Watching system buttons on /dev/input/event0 (Power Button) Jan 29 10:55:24.924586 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: unable to create socket on eth0 (5) for fe80::423:26ff:fed4:1af%2#123 Jan 29 10:55:24.924586 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: failed to init interface for address fe80::423:26ff:fed4:1af%2 Jan 29 10:55:24.924586 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: Listening on routing socket on fd #21 for interface updates Jan 29 10:55:24.885165 ntpd[1835]: available at https://www.nwtime.org/support Jan 29 10:55:24.922582 systemd-logind[1839]: Watching system buttons on /dev/input/event1 (Sleep Button) Jan 29 10:55:24.885183 ntpd[1835]: ---------------------------------------------------- Jan 29 10:55:24.889779 ntpd[1835]: proto: precision = 0.096 usec (-23) Jan 29 10:55:24.890906 ntpd[1835]: basedate set to 2025-01-17 Jan 29 10:55:24.890941 ntpd[1835]: gps base set to 2025-01-19 (week 2350) Jan 29 10:55:24.904426 ntpd[1835]: Listen and drop on 0 v6wildcard [::]:123 Jan 29 10:55:24.904506 ntpd[1835]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jan 29 10:55:24.904778 ntpd[1835]: Listen normally on 2 lo 127.0.0.1:123 Jan 29 10:55:24.904847 ntpd[1835]: Listen normally on 3 eth0 172.31.29.188:123 Jan 29 10:55:24.904924 ntpd[1835]: Listen normally on 4 lo [::1]:123 Jan 29 10:55:24.904995 ntpd[1835]: bind(21) AF_INET6 fe80::423:26ff:fed4:1af%2#123 flags 0x11 failed: Cannot assign requested address Jan 29 10:55:24.913084 ntpd[1835]: unable to create socket on eth0 (5) for fe80::423:26ff:fed4:1af%2#123 Jan 29 10:55:24.913126 ntpd[1835]: failed to init interface for address fe80::423:26ff:fed4:1af%2 Jan 29 10:55:24.913196 ntpd[1835]: Listening on routing socket on fd #21 for interface updates Jan 29 10:55:24.926877 systemd[1]: motdgen.service: Deactivated successfully. Jan 29 10:55:24.927275 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 29 10:55:24.936158 systemd-logind[1839]: New seat seat0. Jan 29 10:55:24.940837 ntpd[1835]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 29 10:55:24.941309 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 29 10:55:24.941309 ntpd[1835]: 29 Jan 10:55:24 ntpd[1835]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 29 10:55:24.940894 ntpd[1835]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 29 10:55:24.950907 systemd[1]: Started systemd-logind.service - User Login Management. Jan 29 10:55:24.960055 extend-filesystems[1833]: Resized partition /dev/nvme0n1p9 Jan 29 10:55:24.975829 extend-filesystems[1878]: resize2fs 1.47.1 (20-May-2024) Jan 29 10:55:24.986633 systemd[1]: Finished setup-oem.service - Setup OEM. Jan 29 10:55:25.001465 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Jan 29 10:55:25.007987 jq[1870]: true Jan 29 10:55:25.008470 update_engine[1841]: I20250129 10:55:24.998935 1841 main.cc:92] Flatcar Update Engine starting Jan 29 10:55:25.022506 systemd[1]: Started update-engine.service - Update Engine. Jan 29 10:55:25.025812 update_engine[1841]: I20250129 10:55:25.025482 1841 update_check_scheduler.cc:74] Next update check in 7m15s Jan 29 10:55:25.030205 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 29 10:55:25.111157 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Jan 29 10:55:25.124146 extend-filesystems[1878]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Jan 29 10:55:25.124146 extend-filesystems[1878]: old_desc_blocks = 1, new_desc_blocks = 1 Jan 29 10:55:25.124146 extend-filesystems[1878]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Jan 29 10:55:25.138080 extend-filesystems[1833]: Resized filesystem in /dev/nvme0n1p9 Jan 29 10:55:25.127350 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 29 10:55:25.130537 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 29 10:55:25.179133 coreos-metadata[1830]: Jan 29 10:55:25.179 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Jan 29 10:55:25.179133 coreos-metadata[1830]: Jan 29 10:55:25.179 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Jan 29 10:55:25.180342 coreos-metadata[1830]: Jan 29 10:55:25.180 INFO Fetch successful Jan 29 10:55:25.180342 coreos-metadata[1830]: Jan 29 10:55:25.180 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Jan 29 10:55:25.185146 coreos-metadata[1830]: Jan 29 10:55:25.182 INFO Fetch successful Jan 29 10:55:25.185146 coreos-metadata[1830]: Jan 29 10:55:25.182 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Jan 29 10:55:25.185684 coreos-metadata[1830]: Jan 29 10:55:25.185 INFO Fetch successful Jan 29 10:55:25.185684 coreos-metadata[1830]: Jan 29 10:55:25.185 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Jan 29 10:55:25.191069 coreos-metadata[1830]: Jan 29 10:55:25.190 INFO Fetch successful Jan 29 10:55:25.191069 coreos-metadata[1830]: Jan 29 10:55:25.190 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Jan 29 10:55:25.195653 coreos-metadata[1830]: Jan 29 10:55:25.195 INFO Fetch failed with 404: resource not found Jan 29 10:55:25.195653 coreos-metadata[1830]: Jan 29 10:55:25.195 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Jan 29 10:55:25.197123 coreos-metadata[1830]: Jan 29 10:55:25.197 INFO Fetch successful Jan 29 10:55:25.197123 coreos-metadata[1830]: Jan 29 10:55:25.197 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Jan 29 10:55:25.197927 coreos-metadata[1830]: Jan 29 10:55:25.197 INFO Fetch successful Jan 29 10:55:25.197927 coreos-metadata[1830]: Jan 29 10:55:25.197 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Jan 29 10:55:25.208153 coreos-metadata[1830]: Jan 29 10:55:25.207 INFO Fetch successful Jan 29 10:55:25.208153 coreos-metadata[1830]: Jan 29 10:55:25.207 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Jan 29 10:55:25.208611 coreos-metadata[1830]: Jan 29 10:55:25.208 INFO Fetch successful Jan 29 10:55:25.208611 coreos-metadata[1830]: Jan 29 10:55:25.208 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Jan 29 10:55:25.211450 coreos-metadata[1830]: Jan 29 10:55:25.209 INFO Fetch successful Jan 29 10:55:25.260688 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 29 10:55:25.280493 bash[1910]: Updated "/home/core/.ssh/authorized_keys" Jan 29 10:55:25.310591 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jan 29 10:55:25.324590 systemd[1]: Starting sshkeys.service... Jan 29 10:55:25.333172 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jan 29 10:55:25.335913 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jan 29 10:55:25.345411 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 39 scanned by (udev-worker) (1715) Jan 29 10:55:25.361514 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Jan 29 10:55:25.369673 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Jan 29 10:55:25.389109 systemd-networkd[1696]: eth0: Gained IPv6LL Jan 29 10:55:25.403833 dbus-daemon[1831]: [system] Successfully activated service 'org.freedesktop.hostname1' Jan 29 10:55:25.404140 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 29 10:55:25.407593 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Jan 29 10:55:25.411044 systemd[1]: Reached target network-online.target - Network is Online. Jan 29 10:55:25.413667 dbus-daemon[1831]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1868 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Jan 29 10:55:25.417666 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Jan 29 10:55:25.424553 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 29 10:55:25.439813 systemd[1]: Starting polkit.service - Authorization Manager... Jan 29 10:55:25.470657 locksmithd[1883]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 29 10:55:25.489457 polkitd[1948]: Started polkitd version 121 Jan 29 10:55:25.548323 polkitd[1948]: Loading rules from directory /etc/polkit-1/rules.d Jan 29 10:55:25.548468 polkitd[1948]: Loading rules from directory /usr/share/polkit-1/rules.d Jan 29 10:55:25.554077 polkitd[1948]: Finished loading, compiling and executing 2 rules Jan 29 10:55:25.559105 dbus-daemon[1831]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jan 29 10:55:25.559398 systemd[1]: Started polkit.service - Authorization Manager. Jan 29 10:55:25.561516 polkitd[1948]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Jan 29 10:55:25.595951 amazon-ssm-agent[1946]: Initializing new seelog logger Jan 29 10:55:25.595951 amazon-ssm-agent[1946]: New Seelog Logger Creation Complete Jan 29 10:55:25.596499 amazon-ssm-agent[1946]: 2025/01/29 10:55:25 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:55:25.596499 amazon-ssm-agent[1946]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:55:25.599134 amazon-ssm-agent[1946]: 2025/01/29 10:55:25 processing appconfig overrides Jan 29 10:55:25.599134 amazon-ssm-agent[1946]: 2025/01/29 10:55:25 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:55:25.599134 amazon-ssm-agent[1946]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:55:25.599134 amazon-ssm-agent[1946]: 2025/01/29 10:55:25 processing appconfig overrides Jan 29 10:55:25.599134 amazon-ssm-agent[1946]: 2025/01/29 10:55:25 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:55:25.599134 amazon-ssm-agent[1946]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:55:25.599134 amazon-ssm-agent[1946]: 2025/01/29 10:55:25 processing appconfig overrides Jan 29 10:55:25.599134 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO Proxy environment variables: Jan 29 10:55:25.605591 amazon-ssm-agent[1946]: 2025/01/29 10:55:25 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:55:25.605591 amazon-ssm-agent[1946]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jan 29 10:55:25.605591 amazon-ssm-agent[1946]: 2025/01/29 10:55:25 processing appconfig overrides Jan 29 10:55:25.628333 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 29 10:55:25.638613 systemd-hostnamed[1868]: Hostname set to (transient) Jan 29 10:55:25.639439 systemd-resolved[1648]: System hostname changed to 'ip-172-31-29-188'. Jan 29 10:55:25.655058 containerd[1859]: time="2025-01-29T10:55:25.651642705Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Jan 29 10:55:25.703183 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO no_proxy: Jan 29 10:55:25.714776 coreos-metadata[1931]: Jan 29 10:55:25.714 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Jan 29 10:55:25.716227 coreos-metadata[1931]: Jan 29 10:55:25.715 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Jan 29 10:55:25.723158 coreos-metadata[1931]: Jan 29 10:55:25.720 INFO Fetch successful Jan 29 10:55:25.723158 coreos-metadata[1931]: Jan 29 10:55:25.720 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Jan 29 10:55:25.723806 coreos-metadata[1931]: Jan 29 10:55:25.723 INFO Fetch successful Jan 29 10:55:25.732504 unknown[1931]: wrote ssh authorized keys file for user: core Jan 29 10:55:25.788716 update-ssh-keys[2016]: Updated "/home/core/.ssh/authorized_keys" Jan 29 10:55:25.789146 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Jan 29 10:55:25.797630 systemd[1]: Finished sshkeys.service. Jan 29 10:55:25.803049 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO https_proxy: Jan 29 10:55:25.829052 containerd[1859]: time="2025-01-29T10:55:25.826643662Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jan 29 10:55:25.831485 containerd[1859]: time="2025-01-29T10:55:25.831407770Z" 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:55:25.831485 containerd[1859]: time="2025-01-29T10:55:25.831474070Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jan 29 10:55:25.831642 containerd[1859]: time="2025-01-29T10:55:25.831513682Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jan 29 10:55:25.831888 containerd[1859]: time="2025-01-29T10:55:25.831843610Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jan 29 10:55:25.831945 containerd[1859]: time="2025-01-29T10:55:25.831891958Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jan 29 10:55:25.833182 containerd[1859]: time="2025-01-29T10:55:25.832015534Z" 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:55:25.833182 containerd[1859]: time="2025-01-29T10:55:25.833174602Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jan 29 10:55:25.833605 containerd[1859]: time="2025-01-29T10:55:25.833553118Z" 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:55:25.833668 containerd[1859]: time="2025-01-29T10:55:25.833597818Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jan 29 10:55:25.833668 containerd[1859]: time="2025-01-29T10:55:25.833632054Z" 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:55:25.833668 containerd[1859]: time="2025-01-29T10:55:25.833655814Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jan 29 10:55:25.833868 containerd[1859]: time="2025-01-29T10:55:25.833828026Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jan 29 10:55:25.836089 containerd[1859]: time="2025-01-29T10:55:25.835381858Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jan 29 10:55:25.836089 containerd[1859]: time="2025-01-29T10:55:25.835648906Z" 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:55:25.836089 containerd[1859]: time="2025-01-29T10:55:25.835680322Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jan 29 10:55:25.836089 containerd[1859]: time="2025-01-29T10:55:25.835855234Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jan 29 10:55:25.836089 containerd[1859]: time="2025-01-29T10:55:25.835949110Z" level=info msg="metadata content store policy set" policy=shared Jan 29 10:55:25.844101 containerd[1859]: time="2025-01-29T10:55:25.843986182Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jan 29 10:55:25.844215 containerd[1859]: time="2025-01-29T10:55:25.844154734Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jan 29 10:55:25.844307 containerd[1859]: time="2025-01-29T10:55:25.844250782Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jan 29 10:55:25.844307 containerd[1859]: time="2025-01-29T10:55:25.844291078Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jan 29 10:55:25.844391 containerd[1859]: time="2025-01-29T10:55:25.844329646Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jan 29 10:55:25.846057 containerd[1859]: time="2025-01-29T10:55:25.844585546Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846405598Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846661306Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846702526Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846735202Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846766174Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846794974Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846823246Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846854374Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846885490Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846914722Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846946762Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.846976438Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.847014994Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848079 containerd[1859]: time="2025-01-29T10:55:25.847438330Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847475506Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847506610Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847535746Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847571638Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847601674Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847654630Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847688086Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847721254Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847748578Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847787890Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847817662Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847848778Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847891738Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847933282Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.848670 containerd[1859]: time="2025-01-29T10:55:25.847961026Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jan 29 10:55:25.849312 containerd[1859]: time="2025-01-29T10:55:25.849013258Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jan 29 10:55:25.849312 containerd[1859]: time="2025-01-29T10:55:25.849217678Z" 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:55:25.849312 containerd[1859]: time="2025-01-29T10:55:25.849247618Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jan 29 10:55:25.849312 containerd[1859]: time="2025-01-29T10:55:25.849278326Z" 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:55:25.849312 containerd[1859]: time="2025-01-29T10:55:25.849304750Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.849520 containerd[1859]: time="2025-01-29T10:55:25.849335194Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jan 29 10:55:25.849520 containerd[1859]: time="2025-01-29T10:55:25.849358486Z" level=info msg="NRI interface is disabled by configuration." Jan 29 10:55:25.849520 containerd[1859]: time="2025-01-29T10:55:25.849383290Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jan 29 10:55:25.852070 containerd[1859]: time="2025-01-29T10:55:25.849900298Z" 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:55:25.852070 containerd[1859]: time="2025-01-29T10:55:25.849998470Z" level=info msg="Connect containerd service" Jan 29 10:55:25.852070 containerd[1859]: time="2025-01-29T10:55:25.851155738Z" level=info msg="using legacy CRI server" Jan 29 10:55:25.852070 containerd[1859]: time="2025-01-29T10:55:25.851191174Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 29 10:55:25.855192 containerd[1859]: time="2025-01-29T10:55:25.855112066Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jan 29 10:55:25.862067 containerd[1859]: time="2025-01-29T10:55:25.859984066Z" 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:55:25.868046 containerd[1859]: time="2025-01-29T10:55:25.866283442Z" level=info msg="Start subscribing containerd event" Jan 29 10:55:25.868046 containerd[1859]: time="2025-01-29T10:55:25.866389270Z" level=info msg="Start recovering state" Jan 29 10:55:25.868046 containerd[1859]: time="2025-01-29T10:55:25.866509126Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 29 10:55:25.868046 containerd[1859]: time="2025-01-29T10:55:25.866609446Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 29 10:55:25.868046 containerd[1859]: time="2025-01-29T10:55:25.866514502Z" level=info msg="Start event monitor" Jan 29 10:55:25.868046 containerd[1859]: time="2025-01-29T10:55:25.866661502Z" level=info msg="Start snapshots syncer" Jan 29 10:55:25.868046 containerd[1859]: time="2025-01-29T10:55:25.866690026Z" level=info msg="Start cni network conf syncer for default" Jan 29 10:55:25.868046 containerd[1859]: time="2025-01-29T10:55:25.866708686Z" level=info msg="Start streaming server" Jan 29 10:55:25.868046 containerd[1859]: time="2025-01-29T10:55:25.866826634Z" level=info msg="containerd successfully booted in 0.228434s" Jan 29 10:55:25.870571 systemd[1]: Started containerd.service - containerd container runtime. Jan 29 10:55:25.903062 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO http_proxy: Jan 29 10:55:25.999898 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO Checking if agent identity type OnPrem can be assumed Jan 29 10:55:26.098165 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO Checking if agent identity type EC2 can be assumed Jan 29 10:55:26.197380 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO Agent will take identity from EC2 Jan 29 10:55:26.248233 sshd_keygen[1867]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jan 29 10:55:26.290437 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 29 10:55:26.299042 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO [amazon-ssm-agent] using named pipe channel for IPC Jan 29 10:55:26.302498 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 29 10:55:26.314601 systemd[1]: Started sshd@0-172.31.29.188:22-139.178.89.65:60584.service - OpenSSH per-connection server daemon (139.178.89.65:60584). Jan 29 10:55:26.336489 systemd[1]: issuegen.service: Deactivated successfully. Jan 29 10:55:26.338289 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 29 10:55:26.354599 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 29 10:55:26.398014 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO [amazon-ssm-agent] using named pipe channel for IPC Jan 29 10:55:26.398160 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 29 10:55:26.408574 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 29 10:55:26.422610 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jan 29 10:55:26.427521 systemd[1]: Reached target getty.target - Login Prompts. Jan 29 10:55:26.431400 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 29 10:55:26.433535 systemd[1]: Startup finished in 1.089s (kernel) + 7.124s (initrd) + 6.558s (userspace) = 14.772s. Jan 29 10:55:26.497364 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO [amazon-ssm-agent] using named pipe channel for IPC Jan 29 10:55:26.593047 sshd[2057]: Accepted publickey for core from 139.178.89.65 port 60584 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:26.594441 sshd-session[2057]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:26.597540 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Jan 29 10:55:26.612875 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 29 10:55:26.623534 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 29 10:55:26.627911 systemd-logind[1839]: New session 1 of user core. Jan 29 10:55:26.658656 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 29 10:55:26.670640 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 29 10:55:26.686922 (systemd)[2072]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 29 10:55:26.697048 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Jan 29 10:55:26.797328 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO [amazon-ssm-agent] Starting Core Agent Jan 29 10:55:26.815100 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO [amazon-ssm-agent] registrar detected. Attempting registration Jan 29 10:55:26.815100 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO [Registrar] Starting registrar module Jan 29 10:55:26.816144 amazon-ssm-agent[1946]: 2025-01-29 10:55:25 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Jan 29 10:55:26.816144 amazon-ssm-agent[1946]: 2025-01-29 10:55:26 INFO [EC2Identity] EC2 registration was successful. Jan 29 10:55:26.816144 amazon-ssm-agent[1946]: 2025-01-29 10:55:26 INFO [CredentialRefresher] credentialRefresher has started Jan 29 10:55:26.816144 amazon-ssm-agent[1946]: 2025-01-29 10:55:26 INFO [CredentialRefresher] Starting credentials refresher loop Jan 29 10:55:26.816144 amazon-ssm-agent[1946]: 2025-01-29 10:55:26 INFO EC2RoleProvider Successfully connected with instance profile role credentials Jan 29 10:55:26.896767 amazon-ssm-agent[1946]: 2025-01-29 10:55:26 INFO [CredentialRefresher] Next credential rotation will be in 31.091657276566668 minutes Jan 29 10:55:26.909058 systemd[2072]: Queued start job for default target default.target. Jan 29 10:55:26.921706 systemd[2072]: Created slice app.slice - User Application Slice. Jan 29 10:55:26.921904 systemd[2072]: Reached target paths.target - Paths. Jan 29 10:55:26.922084 systemd[2072]: Reached target timers.target - Timers. Jan 29 10:55:26.924588 systemd[2072]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 29 10:55:26.945597 systemd[2072]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 29 10:55:26.945837 systemd[2072]: Reached target sockets.target - Sockets. Jan 29 10:55:26.945869 systemd[2072]: Reached target basic.target - Basic System. Jan 29 10:55:26.945971 systemd[2072]: Reached target default.target - Main User Target. Jan 29 10:55:26.946280 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 29 10:55:26.946563 systemd[2072]: Startup finished in 247ms. Jan 29 10:55:26.955560 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 29 10:55:27.110510 systemd[1]: Started sshd@1-172.31.29.188:22-139.178.89.65:60590.service - OpenSSH per-connection server daemon (139.178.89.65:60590). Jan 29 10:55:27.292325 sshd[2083]: Accepted publickey for core from 139.178.89.65 port 60590 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:27.294737 sshd-session[2083]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:27.302054 systemd-logind[1839]: New session 2 of user core. Jan 29 10:55:27.312272 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 29 10:55:27.436407 sshd[2085]: Connection closed by 139.178.89.65 port 60590 Jan 29 10:55:27.437202 sshd-session[2083]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:27.443480 systemd[1]: sshd@1-172.31.29.188:22-139.178.89.65:60590.service: Deactivated successfully. Jan 29 10:55:27.447146 systemd[1]: session-2.scope: Deactivated successfully. Jan 29 10:55:27.449327 systemd-logind[1839]: Session 2 logged out. Waiting for processes to exit. Jan 29 10:55:27.451105 systemd-logind[1839]: Removed session 2. Jan 29 10:55:27.493728 systemd[1]: Started sshd@2-172.31.29.188:22-139.178.89.65:60592.service - OpenSSH per-connection server daemon (139.178.89.65:60592). Jan 29 10:55:27.678643 sshd[2090]: Accepted publickey for core from 139.178.89.65 port 60592 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:27.680490 sshd-session[2090]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:27.687699 systemd-logind[1839]: New session 3 of user core. Jan 29 10:55:27.695285 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 29 10:55:27.816216 sshd[2092]: Connection closed by 139.178.89.65 port 60592 Jan 29 10:55:27.817324 sshd-session[2090]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:27.824808 systemd[1]: sshd@2-172.31.29.188:22-139.178.89.65:60592.service: Deactivated successfully. Jan 29 10:55:27.829627 systemd[1]: session-3.scope: Deactivated successfully. Jan 29 10:55:27.831810 systemd-logind[1839]: Session 3 logged out. Waiting for processes to exit. Jan 29 10:55:27.834483 systemd-logind[1839]: Removed session 3. Jan 29 10:55:27.859272 systemd[1]: Started sshd@3-172.31.29.188:22-139.178.89.65:60606.service - OpenSSH per-connection server daemon (139.178.89.65:60606). Jan 29 10:55:27.860804 amazon-ssm-agent[1946]: 2025-01-29 10:55:27 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Jan 29 10:55:27.886360 ntpd[1835]: Listen normally on 6 eth0 [fe80::423:26ff:fed4:1af%2]:123 Jan 29 10:55:27.887012 ntpd[1835]: 29 Jan 10:55:27 ntpd[1835]: Listen normally on 6 eth0 [fe80::423:26ff:fed4:1af%2]:123 Jan 29 10:55:27.960236 amazon-ssm-agent[1946]: 2025-01-29 10:55:27 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2099) started Jan 29 10:55:28.059587 sshd[2098]: Accepted publickey for core from 139.178.89.65 port 60606 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:28.061421 amazon-ssm-agent[1946]: 2025-01-29 10:55:27 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Jan 29 10:55:28.062268 sshd-session[2098]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:28.070073 systemd-logind[1839]: New session 4 of user core. Jan 29 10:55:28.077352 systemd[1]: Started session-4.scope - Session 4 of User core. Jan 29 10:55:28.203078 sshd[2110]: Connection closed by 139.178.89.65 port 60606 Jan 29 10:55:28.203860 sshd-session[2098]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:28.211083 systemd-logind[1839]: Session 4 logged out. Waiting for processes to exit. Jan 29 10:55:28.212384 systemd[1]: sshd@3-172.31.29.188:22-139.178.89.65:60606.service: Deactivated successfully. Jan 29 10:55:28.217470 systemd[1]: session-4.scope: Deactivated successfully. Jan 29 10:55:28.220349 systemd-logind[1839]: Removed session 4. Jan 29 10:55:28.245694 systemd[1]: Started sshd@4-172.31.29.188:22-139.178.89.65:60614.service - OpenSSH per-connection server daemon (139.178.89.65:60614). Jan 29 10:55:28.431317 sshd[2115]: Accepted publickey for core from 139.178.89.65 port 60614 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:28.433742 sshd-session[2115]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:28.440886 systemd-logind[1839]: New session 5 of user core. Jan 29 10:55:28.452290 systemd[1]: Started session-5.scope - Session 5 of User core. Jan 29 10:55:28.601374 sudo[2118]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jan 29 10:55:28.601997 sudo[2118]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:55:28.617560 sudo[2118]: pam_unix(sudo:session): session closed for user root Jan 29 10:55:28.643045 sshd[2117]: Connection closed by 139.178.89.65 port 60614 Jan 29 10:55:28.641936 sshd-session[2115]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:28.647257 systemd[1]: sshd@4-172.31.29.188:22-139.178.89.65:60614.service: Deactivated successfully. Jan 29 10:55:28.650868 systemd[1]: session-5.scope: Deactivated successfully. Jan 29 10:55:28.653773 systemd-logind[1839]: Session 5 logged out. Waiting for processes to exit. Jan 29 10:55:28.656375 systemd-logind[1839]: Removed session 5. Jan 29 10:55:28.672361 systemd[1]: Started sshd@5-172.31.29.188:22-139.178.89.65:60622.service - OpenSSH per-connection server daemon (139.178.89.65:60622). Jan 29 10:55:28.866603 sshd[2123]: Accepted publickey for core from 139.178.89.65 port 60622 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:28.869299 sshd-session[2123]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:28.877948 systemd-logind[1839]: New session 6 of user core. Jan 29 10:55:28.889338 systemd[1]: Started session-6.scope - Session 6 of User core. Jan 29 10:55:28.993999 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:55:28.994675 sudo[2127]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:55:29.000684 sudo[2127]: pam_unix(sudo:session): session closed for user root Jan 29 10:55:29.010683 sudo[2126]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jan 29 10:55:29.011342 sudo[2126]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:55:29.037826 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 10:55:29.090813 augenrules[2149]: No rules Jan 29 10:55:29.092952 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 10:55:29.093516 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 10:55:29.095637 sudo[2126]: pam_unix(sudo:session): session closed for user root Jan 29 10:55:29.119425 sshd[2125]: Connection closed by 139.178.89.65 port 60622 Jan 29 10:55:29.119233 sshd-session[2123]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:29.125138 systemd[1]: sshd@5-172.31.29.188:22-139.178.89.65:60622.service: Deactivated successfully. Jan 29 10:55:29.129555 systemd[1]: session-6.scope: Deactivated successfully. Jan 29 10:55:29.132606 systemd-logind[1839]: Session 6 logged out. Waiting for processes to exit. Jan 29 10:55:29.134525 systemd-logind[1839]: Removed session 6. Jan 29 10:55:29.154995 systemd[1]: Started sshd@6-172.31.29.188:22-139.178.89.65:60628.service - OpenSSH per-connection server daemon (139.178.89.65:60628). Jan 29 10:55:29.348076 sshd[2157]: Accepted publickey for core from 139.178.89.65 port 60628 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:29.350426 sshd-session[2157]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:29.357840 systemd-logind[1839]: New session 7 of user core. Jan 29 10:55:29.366289 systemd[1]: Started session-7.scope - Session 7 of User core. Jan 29 10:55:29.468723 sudo[2160]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mkdir -p . Jan 29 10:55:29.470456 sudo[2160]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:55:29.476468 sudo[2160]: pam_unix(sudo:session): session closed for user root Jan 29 10:55:29.498847 sshd[2159]: Connection closed by 139.178.89.65 port 60628 Jan 29 10:55:29.499641 sshd-session[2157]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:29.505555 systemd[1]: sshd@6-172.31.29.188:22-139.178.89.65:60628.service: Deactivated successfully. Jan 29 10:55:29.508979 systemd[1]: session-7.scope: Deactivated successfully. Jan 29 10:55:29.510381 systemd-logind[1839]: Session 7 logged out. Waiting for processes to exit. Jan 29 10:55:29.512795 systemd-logind[1839]: Removed session 7. Jan 29 10:55:29.536622 systemd[1]: Started sshd@7-172.31.29.188:22-139.178.89.65:60636.service - OpenSSH per-connection server daemon (139.178.89.65:60636). Jan 29 10:55:29.725833 sshd[2165]: Accepted publickey for core from 139.178.89.65 port 60636 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:29.728285 sshd-session[2165]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:29.737375 systemd-logind[1839]: New session 8 of user core. Jan 29 10:55:29.744304 systemd[1]: Started session-8.scope - Session 8 of User core. Jan 29 10:55:29.845360 sudo[2168]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/install -m 0755 /dev/stdin kolet Jan 29 10:55:29.845957 sudo[2168]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:55:30.632112 sudo[2168]: pam_unix(sudo:session): session closed for user root Jan 29 10:55:30.655085 sshd[2167]: Connection closed by 139.178.89.65 port 60636 Jan 29 10:55:30.655850 sshd-session[2165]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:30.661995 systemd[1]: sshd@7-172.31.29.188:22-139.178.89.65:60636.service: Deactivated successfully. Jan 29 10:55:30.665541 systemd[1]: session-8.scope: Deactivated successfully. Jan 29 10:55:30.666940 systemd-logind[1839]: Session 8 logged out. Waiting for processes to exit. Jan 29 10:55:30.669132 systemd-logind[1839]: Removed session 8. Jan 29 10:55:30.698530 systemd[1]: Started sshd@8-172.31.29.188:22-139.178.89.65:60650.service - OpenSSH per-connection server daemon (139.178.89.65:60650). Jan 29 10:55:30.881813 sshd[2173]: Accepted publickey for core from 139.178.89.65 port 60650 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:30.884346 sshd-session[2173]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:30.892112 systemd-logind[1839]: New session 9 of user core. Jan 29 10:55:30.901289 systemd[1]: Started session-9.scope - Session 9 of User core. Jan 29 10:55:31.004905 sudo[2176]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mkdir /var/tls Jan 29 10:55:31.005695 sudo[2176]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:55:31.011554 sudo[2176]: pam_unix(sudo:session): session closed for user root Jan 29 10:55:31.035273 sshd[2175]: Connection closed by 139.178.89.65 port 60650 Jan 29 10:55:31.035158 sshd-session[2173]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:31.040194 systemd-logind[1839]: Session 9 logged out. Waiting for processes to exit. Jan 29 10:55:31.040764 systemd[1]: sshd@8-172.31.29.188:22-139.178.89.65:60650.service: Deactivated successfully. Jan 29 10:55:31.043777 systemd[1]: session-9.scope: Deactivated successfully. Jan 29 10:55:31.047117 systemd-logind[1839]: Removed session 9. Jan 29 10:55:31.066106 systemd[1]: Started sshd@9-172.31.29.188:22-139.178.89.65:60660.service - OpenSSH per-connection server daemon (139.178.89.65:60660). Jan 29 10:55:31.259402 sshd[2181]: Accepted publickey for core from 139.178.89.65 port 60660 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:31.262327 sshd-session[2181]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:31.271238 systemd-logind[1839]: New session 10 of user core. Jan 29 10:55:31.280301 systemd[1]: Started session-10.scope - Session 10 of User core. Jan 29 10:55:31.382855 sudo[2184]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/openssl ecparam -genkey -name secp384r1 -out /var/tls/server.key Jan 29 10:55:31.383975 sudo[2184]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:55:31.470091 sudo[2184]: pam_unix(sudo:session): session closed for user root Jan 29 10:55:31.494054 sshd[2183]: Connection closed by 139.178.89.65 port 60660 Jan 29 10:55:31.492810 sshd-session[2181]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:31.497819 systemd-logind[1839]: Session 10 logged out. Waiting for processes to exit. Jan 29 10:55:31.499420 systemd[1]: sshd@9-172.31.29.188:22-139.178.89.65:60660.service: Deactivated successfully. Jan 29 10:55:31.502311 systemd[1]: session-10.scope: Deactivated successfully. Jan 29 10:55:31.507388 systemd-logind[1839]: Removed session 10. Jan 29 10:55:31.533540 systemd[1]: Started sshd@10-172.31.29.188:22-139.178.89.65:52730.service - OpenSSH per-connection server daemon (139.178.89.65:52730). Jan 29 10:55:31.727724 sshd[2189]: Accepted publickey for core from 139.178.89.65 port 52730 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:31.730153 sshd-session[2189]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:31.737476 systemd-logind[1839]: New session 11 of user core. Jan 29 10:55:31.747236 systemd[1]: Started session-11.scope - Session 11 of User core. Jan 29 10:55:31.850646 sudo[2192]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/bash -c 'openssl req -new -x509 -sha256 -key /var/tls/server.key -out /var/tls/server.crt -days 3650 -subj "/CN=172.31.29.188" -config <(cat <<-EOF#012[req]#012default_bits = 2048#012default_md = sha256#012distinguished_name = dn#012#012[ dn ]#012CN = 172.31.29.188#012#012[ SAN ]#012subjectAltName = IP:172.31.29.188#012EOF#012) -extensions SAN' Jan 29 10:55:31.851326 sudo[2192]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:55:31.870578 sudo[2192]: pam_unix(sudo:session): session closed for user root Jan 29 10:55:31.606637 systemd-resolved[1648]: Clock change detected. Flushing caches. Jan 29 10:55:31.614376 systemd-journald[1488]: Time jumped backwards, rotating. Jan 29 10:55:31.615290 sshd[2191]: Connection closed by 139.178.89.65 port 52730 Jan 29 10:55:31.615176 sshd-session[2189]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:31.622508 systemd[1]: sshd@10-172.31.29.188:22-139.178.89.65:52730.service: Deactivated successfully. Jan 29 10:55:31.628705 systemd[1]: session-11.scope: Deactivated successfully. Jan 29 10:55:31.630008 systemd-logind[1839]: Session 11 logged out. Waiting for processes to exit. Jan 29 10:55:31.632529 systemd-logind[1839]: Removed session 11. Jan 29 10:55:31.664201 systemd[1]: Started sshd@11-172.31.29.188:22-139.178.89.65:52744.service - OpenSSH per-connection server daemon (139.178.89.65:52744). Jan 29 10:55:31.848382 sshd[2199]: Accepted publickey for core from 139.178.89.65 port 52744 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:31.850903 sshd-session[2199]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:31.858152 systemd-logind[1839]: New session 12 of user core. Jan 29 10:55:31.870111 systemd[1]: Started session-12.scope - Session 12 of User core. Jan 29 10:55:31.974876 sudo[2202]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/cat /var/tls/server.crt Jan 29 10:55:31.975476 sudo[2202]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:55:31.981827 sudo[2202]: pam_unix(sudo:session): session closed for user root Jan 29 10:55:32.006385 sshd[2201]: Connection closed by 139.178.89.65 port 52744 Jan 29 10:55:32.005675 sshd-session[2199]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:32.012113 systemd[1]: sshd@11-172.31.29.188:22-139.178.89.65:52744.service: Deactivated successfully. Jan 29 10:55:32.016531 systemd[1]: session-12.scope: Deactivated successfully. Jan 29 10:55:32.017850 systemd-logind[1839]: Session 12 logged out. Waiting for processes to exit. Jan 29 10:55:32.019707 systemd-logind[1839]: Removed session 12. Jan 29 10:55:32.039037 systemd[1]: Started sshd@12-172.31.29.188:22-139.178.89.65:52748.service - OpenSSH per-connection server daemon (139.178.89.65:52748). Jan 29 10:55:32.232627 sshd[2207]: Accepted publickey for core from 139.178.89.65 port 52748 ssh2: RSA SHA256:cIZr/MEwQ13qQ/md8fQDjCFsLmoY1mjzTaFel2uuBoU Jan 29 10:55:32.234365 sshd-session[2207]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 10:55:32.243590 systemd-logind[1839]: New session 13 of user core. Jan 29 10:55:32.246077 systemd[1]: Started session-13.scope - Session 13 of User core. Jan 29 10:55:32.349146 sudo[2210]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemd-run --quiet ./kolet run coreos.ignition.security.tls TLSServe Jan 29 10:55:32.350264 sudo[2210]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 10:55:32.375430 systemd[1]: Started run-rf114abd816214d35aee066b3fdba3acf.service - /home/core/./kolet run coreos.ignition.security.tls TLSServe. Jan 29 10:55:32.377956 sudo[2210]: pam_unix(sudo:session): session closed for user root Jan 29 10:55:32.401001 sshd[2209]: Connection closed by 139.178.89.65 port 52748 Jan 29 10:55:32.401811 sshd-session[2207]: pam_unix(sshd:session): session closed for user core Jan 29 10:55:32.408909 systemd[1]: sshd@12-172.31.29.188:22-139.178.89.65:52748.service: Deactivated successfully. Jan 29 10:55:32.413514 systemd[1]: session-13.scope: Deactivated successfully. Jan 29 10:55:32.420595 systemd-logind[1839]: Session 13 logged out. Waiting for processes to exit. Jan 29 10:55:32.422357 systemd-logind[1839]: Removed session 13. Jan 29 10:55:55.386262 systemd[1]: systemd-hostnamed.service: Deactivated successfully.