Nov 12 22:22:29.235484 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Nov 12 22:22:29.235528 kernel: Linux version 6.6.60-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Tue Nov 12 21:07:55 -00 2024 Nov 12 22:22:29.235552 kernel: KASLR disabled due to lack of seed Nov 12 22:22:29.235569 kernel: efi: EFI v2.7 by EDK II Nov 12 22:22:29.235585 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b003a98 MEMRESERVE=0x78503d98 Nov 12 22:22:29.235600 kernel: secureboot: Secure boot disabled Nov 12 22:22:29.235618 kernel: ACPI: Early table checksum verification disabled Nov 12 22:22:29.235633 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Nov 12 22:22:29.235649 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Nov 12 22:22:29.235665 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Nov 12 22:22:29.235685 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Nov 12 22:22:29.235701 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Nov 12 22:22:29.235716 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Nov 12 22:22:29.235731 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Nov 12 22:22:29.235750 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Nov 12 22:22:29.235769 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Nov 12 22:22:29.236844 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Nov 12 22:22:29.236862 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Nov 12 22:22:29.236878 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Nov 12 22:22:29.236895 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Nov 12 22:22:29.236911 kernel: printk: bootconsole [uart0] enabled Nov 12 22:22:29.236927 kernel: NUMA: Failed to initialise from firmware Nov 12 22:22:29.236944 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Nov 12 22:22:29.236960 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Nov 12 22:22:29.236976 kernel: Zone ranges: Nov 12 22:22:29.236993 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Nov 12 22:22:29.237016 kernel: DMA32 empty Nov 12 22:22:29.237032 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Nov 12 22:22:29.237048 kernel: Movable zone start for each node Nov 12 22:22:29.237065 kernel: Early memory node ranges Nov 12 22:22:29.237081 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Nov 12 22:22:29.237097 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Nov 12 22:22:29.237113 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Nov 12 22:22:29.237129 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Nov 12 22:22:29.237145 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Nov 12 22:22:29.237161 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Nov 12 22:22:29.237177 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Nov 12 22:22:29.237192 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Nov 12 22:22:29.237212 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Nov 12 22:22:29.237229 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Nov 12 22:22:29.237252 kernel: psci: probing for conduit method from ACPI. Nov 12 22:22:29.237269 kernel: psci: PSCIv1.0 detected in firmware. Nov 12 22:22:29.237286 kernel: psci: Using standard PSCI v0.2 function IDs Nov 12 22:22:29.237307 kernel: psci: Trusted OS migration not required Nov 12 22:22:29.237324 kernel: psci: SMC Calling Convention v1.1 Nov 12 22:22:29.237341 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Nov 12 22:22:29.237358 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Nov 12 22:22:29.237376 kernel: pcpu-alloc: [0] 0 [0] 1 Nov 12 22:22:29.237392 kernel: Detected PIPT I-cache on CPU0 Nov 12 22:22:29.237409 kernel: CPU features: detected: GIC system register CPU interface Nov 12 22:22:29.237426 kernel: CPU features: detected: Spectre-v2 Nov 12 22:22:29.237443 kernel: CPU features: detected: Spectre-v3a Nov 12 22:22:29.237459 kernel: CPU features: detected: Spectre-BHB Nov 12 22:22:29.237476 kernel: CPU features: detected: ARM erratum 1742098 Nov 12 22:22:29.237493 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Nov 12 22:22:29.237514 kernel: alternatives: applying boot alternatives Nov 12 22:22:29.237533 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=054b3f497d0699ec5dd6f755e221ed9e2d4f35054d20dd4fb5abe997efb88cfb Nov 12 22:22:29.237551 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Nov 12 22:22:29.237568 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 12 22:22:29.237585 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 12 22:22:29.237602 kernel: Fallback order for Node 0: 0 Nov 12 22:22:29.237619 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Nov 12 22:22:29.237636 kernel: Policy zone: Normal Nov 12 22:22:29.237652 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 12 22:22:29.237669 kernel: software IO TLB: area num 2. Nov 12 22:22:29.237690 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Nov 12 22:22:29.237708 kernel: Memory: 3819960K/4030464K available (10240K kernel code, 2184K rwdata, 8096K rodata, 39680K init, 897K bss, 210504K reserved, 0K cma-reserved) Nov 12 22:22:29.237725 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Nov 12 22:22:29.237742 kernel: trace event string verifier disabled Nov 12 22:22:29.237758 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 12 22:22:29.237809 kernel: rcu: RCU event tracing is enabled. Nov 12 22:22:29.237832 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Nov 12 22:22:29.237849 kernel: Trampoline variant of Tasks RCU enabled. Nov 12 22:22:29.237867 kernel: Tracing variant of Tasks RCU enabled. Nov 12 22:22:29.237884 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 12 22:22:29.237901 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Nov 12 22:22:29.237923 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 12 22:22:29.237940 kernel: GICv3: 96 SPIs implemented Nov 12 22:22:29.237957 kernel: GICv3: 0 Extended SPIs implemented Nov 12 22:22:29.237974 kernel: Root IRQ handler: gic_handle_irq Nov 12 22:22:29.237991 kernel: GICv3: GICv3 features: 16 PPIs Nov 12 22:22:29.238008 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Nov 12 22:22:29.238025 kernel: ITS [mem 0x10080000-0x1009ffff] Nov 12 22:22:29.238042 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Nov 12 22:22:29.238060 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Nov 12 22:22:29.238077 kernel: GICv3: using LPI property table @0x00000004000d0000 Nov 12 22:22:29.238094 kernel: ITS: Using hypervisor restricted LPI range [128] Nov 12 22:22:29.238111 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Nov 12 22:22:29.238132 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 12 22:22:29.238149 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Nov 12 22:22:29.238166 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Nov 12 22:22:29.238184 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Nov 12 22:22:29.238201 kernel: Console: colour dummy device 80x25 Nov 12 22:22:29.238219 kernel: printk: console [tty1] enabled Nov 12 22:22:29.238236 kernel: ACPI: Core revision 20230628 Nov 12 22:22:29.238254 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Nov 12 22:22:29.238271 kernel: pid_max: default: 32768 minimum: 301 Nov 12 22:22:29.238289 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Nov 12 22:22:29.238311 kernel: landlock: Up and running. Nov 12 22:22:29.238328 kernel: SELinux: Initializing. Nov 12 22:22:29.238346 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 12 22:22:29.238363 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 12 22:22:29.238381 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Nov 12 22:22:29.238398 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Nov 12 22:22:29.238416 kernel: rcu: Hierarchical SRCU implementation. Nov 12 22:22:29.238433 kernel: rcu: Max phase no-delay instances is 400. Nov 12 22:22:29.238451 kernel: Platform MSI: ITS@0x10080000 domain created Nov 12 22:22:29.238472 kernel: PCI/MSI: ITS@0x10080000 domain created Nov 12 22:22:29.238489 kernel: Remapping and enabling EFI services. Nov 12 22:22:29.238506 kernel: smp: Bringing up secondary CPUs ... Nov 12 22:22:29.238524 kernel: Detected PIPT I-cache on CPU1 Nov 12 22:22:29.238542 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Nov 12 22:22:29.238559 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Nov 12 22:22:29.238577 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Nov 12 22:22:29.238594 kernel: smp: Brought up 1 node, 2 CPUs Nov 12 22:22:29.238611 kernel: SMP: Total of 2 processors activated. Nov 12 22:22:29.238633 kernel: CPU features: detected: 32-bit EL0 Support Nov 12 22:22:29.238651 kernel: CPU features: detected: 32-bit EL1 Support Nov 12 22:22:29.238679 kernel: CPU features: detected: CRC32 instructions Nov 12 22:22:29.238700 kernel: CPU: All CPU(s) started at EL1 Nov 12 22:22:29.238719 kernel: alternatives: applying system-wide alternatives Nov 12 22:22:29.238737 kernel: devtmpfs: initialized Nov 12 22:22:29.238755 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 12 22:22:29.240814 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Nov 12 22:22:29.240849 kernel: pinctrl core: initialized pinctrl subsystem Nov 12 22:22:29.240876 kernel: SMBIOS 3.0.0 present. Nov 12 22:22:29.240895 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Nov 12 22:22:29.240913 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 12 22:22:29.240932 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 12 22:22:29.240951 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 12 22:22:29.240969 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 12 22:22:29.240987 kernel: audit: initializing netlink subsys (disabled) Nov 12 22:22:29.241010 kernel: audit: type=2000 audit(0.223:1): state=initialized audit_enabled=0 res=1 Nov 12 22:22:29.241028 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 12 22:22:29.241047 kernel: cpuidle: using governor menu Nov 12 22:22:29.241065 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 12 22:22:29.241084 kernel: ASID allocator initialised with 65536 entries Nov 12 22:22:29.241102 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 12 22:22:29.241121 kernel: Serial: AMBA PL011 UART driver Nov 12 22:22:29.241139 kernel: Modules: 17440 pages in range for non-PLT usage Nov 12 22:22:29.241157 kernel: Modules: 508960 pages in range for PLT usage Nov 12 22:22:29.241176 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 12 22:22:29.241218 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Nov 12 22:22:29.241240 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Nov 12 22:22:29.241259 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Nov 12 22:22:29.241278 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 12 22:22:29.241297 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Nov 12 22:22:29.241316 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Nov 12 22:22:29.241335 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Nov 12 22:22:29.241353 kernel: ACPI: Added _OSI(Module Device) Nov 12 22:22:29.241371 kernel: ACPI: Added _OSI(Processor Device) Nov 12 22:22:29.241396 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 12 22:22:29.241415 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 12 22:22:29.241433 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 12 22:22:29.241451 kernel: ACPI: Interpreter enabled Nov 12 22:22:29.241470 kernel: ACPI: Using GIC for interrupt routing Nov 12 22:22:29.241488 kernel: ACPI: MCFG table detected, 1 entries Nov 12 22:22:29.241506 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Nov 12 22:22:29.241844 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 12 22:22:29.242089 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 12 22:22:29.242303 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 12 22:22:29.242511 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Nov 12 22:22:29.242725 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Nov 12 22:22:29.242750 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Nov 12 22:22:29.242769 kernel: acpiphp: Slot [1] registered Nov 12 22:22:29.244164 kernel: acpiphp: Slot [2] registered Nov 12 22:22:29.244184 kernel: acpiphp: Slot [3] registered Nov 12 22:22:29.244211 kernel: acpiphp: Slot [4] registered Nov 12 22:22:29.244229 kernel: acpiphp: Slot [5] registered Nov 12 22:22:29.244248 kernel: acpiphp: Slot [6] registered Nov 12 22:22:29.244266 kernel: acpiphp: Slot [7] registered Nov 12 22:22:29.244284 kernel: acpiphp: Slot [8] registered Nov 12 22:22:29.244302 kernel: acpiphp: Slot [9] registered Nov 12 22:22:29.244320 kernel: acpiphp: Slot [10] registered Nov 12 22:22:29.244338 kernel: acpiphp: Slot [11] registered Nov 12 22:22:29.244356 kernel: acpiphp: Slot [12] registered Nov 12 22:22:29.244378 kernel: acpiphp: Slot [13] registered Nov 12 22:22:29.244397 kernel: acpiphp: Slot [14] registered Nov 12 22:22:29.244415 kernel: acpiphp: Slot [15] registered Nov 12 22:22:29.244432 kernel: acpiphp: Slot [16] registered Nov 12 22:22:29.244451 kernel: acpiphp: Slot [17] registered Nov 12 22:22:29.244469 kernel: acpiphp: Slot [18] registered Nov 12 22:22:29.244487 kernel: acpiphp: Slot [19] registered Nov 12 22:22:29.244505 kernel: acpiphp: Slot [20] registered Nov 12 22:22:29.244523 kernel: acpiphp: Slot [21] registered Nov 12 22:22:29.244541 kernel: acpiphp: Slot [22] registered Nov 12 22:22:29.244563 kernel: acpiphp: Slot [23] registered Nov 12 22:22:29.244581 kernel: acpiphp: Slot [24] registered Nov 12 22:22:29.244599 kernel: acpiphp: Slot [25] registered Nov 12 22:22:29.244616 kernel: acpiphp: Slot [26] registered Nov 12 22:22:29.244634 kernel: acpiphp: Slot [27] registered Nov 12 22:22:29.244652 kernel: acpiphp: Slot [28] registered Nov 12 22:22:29.244670 kernel: acpiphp: Slot [29] registered Nov 12 22:22:29.244688 kernel: acpiphp: Slot [30] registered Nov 12 22:22:29.244706 kernel: acpiphp: Slot [31] registered Nov 12 22:22:29.244728 kernel: PCI host bridge to bus 0000:00 Nov 12 22:22:29.244993 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Nov 12 22:22:29.245191 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 12 22:22:29.245391 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Nov 12 22:22:29.245586 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Nov 12 22:22:29.246955 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Nov 12 22:22:29.247258 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Nov 12 22:22:29.247499 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Nov 12 22:22:29.247746 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Nov 12 22:22:29.248033 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Nov 12 22:22:29.248265 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Nov 12 22:22:29.248487 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Nov 12 22:22:29.248693 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Nov 12 22:22:29.249205 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Nov 12 22:22:29.249419 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Nov 12 22:22:29.249638 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Nov 12 22:22:29.249968 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Nov 12 22:22:29.250217 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Nov 12 22:22:29.250440 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Nov 12 22:22:29.250669 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Nov 12 22:22:29.251134 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Nov 12 22:22:29.251337 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Nov 12 22:22:29.251518 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 12 22:22:29.251699 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Nov 12 22:22:29.251723 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Nov 12 22:22:29.251743 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Nov 12 22:22:29.251761 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Nov 12 22:22:29.251802 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Nov 12 22:22:29.251833 kernel: iommu: Default domain type: Translated Nov 12 22:22:29.251852 kernel: iommu: DMA domain TLB invalidation policy: strict mode Nov 12 22:22:29.251870 kernel: efivars: Registered efivars operations Nov 12 22:22:29.251888 kernel: vgaarb: loaded Nov 12 22:22:29.251906 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 12 22:22:29.251924 kernel: VFS: Disk quotas dquot_6.6.0 Nov 12 22:22:29.251943 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 12 22:22:29.251961 kernel: pnp: PnP ACPI init Nov 12 22:22:29.252194 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Nov 12 22:22:29.252228 kernel: pnp: PnP ACPI: found 1 devices Nov 12 22:22:29.252247 kernel: NET: Registered PF_INET protocol family Nov 12 22:22:29.252265 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 12 22:22:29.252284 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 12 22:22:29.252302 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 12 22:22:29.252320 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 12 22:22:29.252339 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Nov 12 22:22:29.252357 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 12 22:22:29.252380 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 12 22:22:29.252398 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 12 22:22:29.252416 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 12 22:22:29.252434 kernel: PCI: CLS 0 bytes, default 64 Nov 12 22:22:29.252452 kernel: kvm [1]: HYP mode not available Nov 12 22:22:29.252470 kernel: Initialise system trusted keyrings Nov 12 22:22:29.252489 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 12 22:22:29.252507 kernel: Key type asymmetric registered Nov 12 22:22:29.252525 kernel: Asymmetric key parser 'x509' registered Nov 12 22:22:29.252547 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 12 22:22:29.252566 kernel: io scheduler mq-deadline registered Nov 12 22:22:29.252585 kernel: io scheduler kyber registered Nov 12 22:22:29.252603 kernel: io scheduler bfq registered Nov 12 22:22:29.252835 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Nov 12 22:22:29.252866 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 12 22:22:29.252885 kernel: ACPI: button: Power Button [PWRB] Nov 12 22:22:29.252904 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Nov 12 22:22:29.252924 kernel: ACPI: button: Sleep Button [SLPB] Nov 12 22:22:29.252950 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 12 22:22:29.252970 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Nov 12 22:22:29.253191 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Nov 12 22:22:29.253217 kernel: printk: console [ttyS0] disabled Nov 12 22:22:29.253236 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Nov 12 22:22:29.253255 kernel: printk: console [ttyS0] enabled Nov 12 22:22:29.253274 kernel: printk: bootconsole [uart0] disabled Nov 12 22:22:29.253292 kernel: thunder_xcv, ver 1.0 Nov 12 22:22:29.253310 kernel: thunder_bgx, ver 1.0 Nov 12 22:22:29.253335 kernel: nicpf, ver 1.0 Nov 12 22:22:29.253354 kernel: nicvf, ver 1.0 Nov 12 22:22:29.253587 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 12 22:22:29.253831 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-11-12T22:22:28 UTC (1731450148) Nov 12 22:22:29.253862 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 12 22:22:29.253881 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Nov 12 22:22:29.253900 kernel: watchdog: Delayed init of the lockup detector failed: -19 Nov 12 22:22:29.253920 kernel: watchdog: Hard watchdog permanently disabled Nov 12 22:22:29.253953 kernel: NET: Registered PF_INET6 protocol family Nov 12 22:22:29.253972 kernel: Segment Routing with IPv6 Nov 12 22:22:29.253990 kernel: In-situ OAM (IOAM) with IPv6 Nov 12 22:22:29.254009 kernel: NET: Registered PF_PACKET protocol family Nov 12 22:22:29.254030 kernel: Key type dns_resolver registered Nov 12 22:22:29.254064 kernel: registered taskstats version 1 Nov 12 22:22:29.254104 kernel: Loading compiled-in X.509 certificates Nov 12 22:22:29.254161 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.60-flatcar: 27dd0d090d7a0971a24582c9198f7e80123ea69f' Nov 12 22:22:29.254197 kernel: Key type .fscrypt registered Nov 12 22:22:29.254225 kernel: Key type fscrypt-provisioning registered Nov 12 22:22:29.254244 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 12 22:22:29.254268 kernel: ima: Allocated hash algorithm: sha1 Nov 12 22:22:29.254293 kernel: ima: No architecture policies found Nov 12 22:22:29.254311 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Nov 12 22:22:29.254329 kernel: clk: Disabling unused clocks Nov 12 22:22:29.254347 kernel: Freeing unused kernel memory: 39680K Nov 12 22:22:29.254366 kernel: Run /init as init process Nov 12 22:22:29.254384 kernel: with arguments: Nov 12 22:22:29.254406 kernel: /init Nov 12 22:22:29.254424 kernel: with environment: Nov 12 22:22:29.254442 kernel: HOME=/ Nov 12 22:22:29.254460 kernel: TERM=linux Nov 12 22:22:29.254478 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 12 22:22:29.254502 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) Nov 12 22:22:29.254525 systemd[1]: Detected virtualization amazon. Nov 12 22:22:29.254545 systemd[1]: Detected architecture arm64. Nov 12 22:22:29.254568 systemd[1]: Running in initrd. Nov 12 22:22:29.254588 systemd[1]: No hostname configured, using default hostname. Nov 12 22:22:29.254606 systemd[1]: Hostname set to . Nov 12 22:22:29.254627 systemd[1]: Initializing machine ID from VM UUID. Nov 12 22:22:29.254646 systemd[1]: Queued start job for default target initrd.target. Nov 12 22:22:29.254666 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 22:22:29.254685 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 22:22:29.254706 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 12 22:22:29.254731 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 12 22:22:29.254751 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 12 22:22:29.254771 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 12 22:22:29.254824 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Nov 12 22:22:29.254847 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Nov 12 22:22:29.254867 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 22:22:29.254895 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 12 22:22:29.254916 systemd[1]: Reached target paths.target - Path Units. Nov 12 22:22:29.254936 systemd[1]: Reached target slices.target - Slice Units. Nov 12 22:22:29.254955 systemd[1]: Reached target swap.target - Swaps. Nov 12 22:22:29.254975 systemd[1]: Reached target timers.target - Timer Units. Nov 12 22:22:29.254995 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 12 22:22:29.255015 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 12 22:22:29.255035 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 12 22:22:29.255054 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Nov 12 22:22:29.255079 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 12 22:22:29.255099 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 12 22:22:29.255118 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 22:22:29.255137 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 22:22:29.255157 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 12 22:22:29.255177 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 12 22:22:29.255197 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 12 22:22:29.255217 systemd[1]: Starting systemd-fsck-usr.service... Nov 12 22:22:29.255237 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 12 22:22:29.255261 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 12 22:22:29.255281 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:22:29.255301 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 12 22:22:29.255320 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 22:22:29.255340 systemd[1]: Finished systemd-fsck-usr.service. Nov 12 22:22:29.255414 systemd-journald[252]: Collecting audit messages is disabled. Nov 12 22:22:29.255462 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 12 22:22:29.255483 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:22:29.255507 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 12 22:22:29.255527 systemd-journald[252]: Journal started Nov 12 22:22:29.255565 systemd-journald[252]: Runtime Journal (/run/log/journal/ec214ffe235bcc518c15f43e13eaab4f) is 8.0M, max 75.3M, 67.3M free. Nov 12 22:22:29.221859 systemd-modules-load[253]: Inserted module 'overlay' Nov 12 22:22:29.266513 systemd[1]: Started systemd-journald.service - Journal Service. Nov 12 22:22:29.271841 kernel: Bridge firewalling registered Nov 12 22:22:29.271756 systemd-modules-load[253]: Inserted module 'br_netfilter' Nov 12 22:22:29.278166 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 22:22:29.291208 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 12 22:22:29.296224 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 12 22:22:29.312937 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 12 22:22:29.335016 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:22:29.348611 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 12 22:22:29.361507 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 12 22:22:29.374086 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 12 22:22:29.382895 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 22:22:29.406854 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 12 22:22:29.417407 dracut-cmdline[277]: dracut-dracut-053 Nov 12 22:22:29.424268 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 12 22:22:29.429646 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 22:22:29.441297 dracut-cmdline[277]: 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=054b3f497d0699ec5dd6f755e221ed9e2d4f35054d20dd4fb5abe997efb88cfb Nov 12 22:22:29.518120 systemd-resolved[293]: Positive Trust Anchors: Nov 12 22:22:29.518180 systemd-resolved[293]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 12 22:22:29.518242 systemd-resolved[293]: 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 Nov 12 22:22:29.609848 kernel: SCSI subsystem initialized Nov 12 22:22:29.617825 kernel: Loading iSCSI transport class v2.0-870. Nov 12 22:22:29.630944 kernel: iscsi: registered transport (tcp) Nov 12 22:22:29.654924 kernel: iscsi: registered transport (qla4xxx) Nov 12 22:22:29.655047 kernel: QLogic iSCSI HBA Driver Nov 12 22:22:29.746155 kernel: random: crng init done Nov 12 22:22:29.746427 systemd-resolved[293]: Defaulting to hostname 'linux'. Nov 12 22:22:29.750665 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 12 22:22:29.755566 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 12 22:22:29.781909 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 12 22:22:29.792156 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 12 22:22:29.840839 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 12 22:22:29.840923 kernel: device-mapper: uevent: version 1.0.3 Nov 12 22:22:29.840951 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Nov 12 22:22:29.909831 kernel: raid6: neonx8 gen() 6761 MB/s Nov 12 22:22:29.926834 kernel: raid6: neonx4 gen() 6569 MB/s Nov 12 22:22:29.943816 kernel: raid6: neonx2 gen() 5459 MB/s Nov 12 22:22:29.960819 kernel: raid6: neonx1 gen() 3953 MB/s Nov 12 22:22:29.977822 kernel: raid6: int64x8 gen() 3818 MB/s Nov 12 22:22:29.994826 kernel: raid6: int64x4 gen() 3708 MB/s Nov 12 22:22:30.011833 kernel: raid6: int64x2 gen() 3618 MB/s Nov 12 22:22:30.029698 kernel: raid6: int64x1 gen() 2767 MB/s Nov 12 22:22:30.029742 kernel: raid6: using algorithm neonx8 gen() 6761 MB/s Nov 12 22:22:30.047847 kernel: raid6: .... xor() 4849 MB/s, rmw enabled Nov 12 22:22:30.047899 kernel: raid6: using neon recovery algorithm Nov 12 22:22:30.055820 kernel: xor: measuring software checksum speed Nov 12 22:22:30.058246 kernel: 8regs : 9841 MB/sec Nov 12 22:22:30.058283 kernel: 32regs : 11529 MB/sec Nov 12 22:22:30.059469 kernel: arm64_neon : 9540 MB/sec Nov 12 22:22:30.059502 kernel: xor: using function: 32regs (11529 MB/sec) Nov 12 22:22:30.144835 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 12 22:22:30.167168 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 12 22:22:30.177139 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 22:22:30.221580 systemd-udevd[471]: Using default interface naming scheme 'v255'. Nov 12 22:22:30.231179 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 22:22:30.246067 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 12 22:22:30.275715 dracut-pre-trigger[475]: rd.md=0: removing MD RAID activation Nov 12 22:22:30.340858 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 12 22:22:30.351106 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 12 22:22:30.478857 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 22:22:30.493368 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 12 22:22:30.540015 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 12 22:22:30.543308 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 12 22:22:30.546344 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 22:22:30.546561 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 12 22:22:30.575512 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 12 22:22:30.626141 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 12 22:22:30.701571 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Nov 12 22:22:30.701664 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Nov 12 22:22:30.715878 kernel: ena 0000:00:05.0: ENA device version: 0.10 Nov 12 22:22:30.716165 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Nov 12 22:22:30.716400 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:ad:d5:a0:0b:0d Nov 12 22:22:30.713632 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 12 22:22:30.713894 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:22:30.721542 (udev-worker)[518]: Network interface NamePolicy= disabled on kernel command line. Nov 12 22:22:30.729955 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 22:22:30.744326 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Nov 12 22:22:30.744415 kernel: nvme nvme0: pci function 0000:00:04.0 Nov 12 22:22:30.748833 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 12 22:22:30.752407 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:22:30.754771 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:22:30.764837 kernel: nvme nvme0: 2/0/0 default/read/poll queues Nov 12 22:22:30.766374 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:22:30.775067 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 12 22:22:30.775141 kernel: GPT:9289727 != 16777215 Nov 12 22:22:30.775167 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 12 22:22:30.775191 kernel: GPT:9289727 != 16777215 Nov 12 22:22:30.775214 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 12 22:22:30.775238 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 12 22:22:30.805898 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:22:30.821053 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 22:22:30.868767 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:22:30.881229 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by (udev-worker) (527) Nov 12 22:22:30.916879 kernel: BTRFS: device fsid 337794e4-53df-462b-aefc-e93e6a958f34 devid 1 transid 41 /dev/nvme0n1p3 scanned by (udev-worker) (529) Nov 12 22:22:30.991154 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Nov 12 22:22:31.013364 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Nov 12 22:22:31.053527 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Nov 12 22:22:31.069329 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Nov 12 22:22:31.074363 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Nov 12 22:22:31.094251 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 12 22:22:31.108078 disk-uuid[662]: Primary Header is updated. Nov 12 22:22:31.108078 disk-uuid[662]: Secondary Entries is updated. Nov 12 22:22:31.108078 disk-uuid[662]: Secondary Header is updated. Nov 12 22:22:31.116822 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 12 22:22:32.127862 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 12 22:22:32.130451 disk-uuid[663]: The operation has completed successfully. Nov 12 22:22:32.355119 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 12 22:22:32.355456 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 12 22:22:32.390248 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Nov 12 22:22:32.409990 sh[923]: Success Nov 12 22:22:32.434818 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 12 22:22:32.557106 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Nov 12 22:22:32.570160 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Nov 12 22:22:32.577985 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Nov 12 22:22:32.618686 kernel: BTRFS info (device dm-0): first mount of filesystem 337794e4-53df-462b-aefc-e93e6a958f34 Nov 12 22:22:32.618864 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Nov 12 22:22:32.618893 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Nov 12 22:22:32.620439 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 12 22:22:32.621703 kernel: BTRFS info (device dm-0): using free space tree Nov 12 22:22:32.677813 kernel: BTRFS info (device dm-0): enabling ssd optimizations Nov 12 22:22:32.714021 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Nov 12 22:22:32.718410 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 12 22:22:32.731241 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 12 22:22:32.736338 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 12 22:22:32.782582 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem e7e17182-4510-4c0b-82ae-ebdf6a7625d9 Nov 12 22:22:32.782680 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Nov 12 22:22:32.783945 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 12 22:22:32.791896 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 12 22:22:32.811993 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 12 22:22:32.815302 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem e7e17182-4510-4c0b-82ae-ebdf6a7625d9 Nov 12 22:22:32.826103 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 12 22:22:32.839323 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 12 22:22:32.940162 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 12 22:22:32.957090 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 12 22:22:33.011517 systemd-networkd[1115]: lo: Link UP Nov 12 22:22:33.011540 systemd-networkd[1115]: lo: Gained carrier Nov 12 22:22:33.016670 systemd-networkd[1115]: Enumeration completed Nov 12 22:22:33.017520 systemd-networkd[1115]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:22:33.017528 systemd-networkd[1115]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 12 22:22:33.019115 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 12 22:22:33.028278 systemd[1]: Reached target network.target - Network. Nov 12 22:22:33.032543 systemd-networkd[1115]: eth0: Link UP Nov 12 22:22:33.032551 systemd-networkd[1115]: eth0: Gained carrier Nov 12 22:22:33.032569 systemd-networkd[1115]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:22:33.057932 systemd-networkd[1115]: eth0: DHCPv4 address 172.31.22.251/20, gateway 172.31.16.1 acquired from 172.31.16.1 Nov 12 22:22:33.252734 ignition[1036]: Ignition 2.20.0 Nov 12 22:22:33.252756 ignition[1036]: Stage: fetch-offline Nov 12 22:22:33.253224 ignition[1036]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:22:33.253247 ignition[1036]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:22:33.256050 ignition[1036]: Ignition finished successfully Nov 12 22:22:33.263110 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 12 22:22:33.279209 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Nov 12 22:22:33.304147 ignition[1126]: Ignition 2.20.0 Nov 12 22:22:33.304173 ignition[1126]: Stage: fetch Nov 12 22:22:33.305953 ignition[1126]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:22:33.305978 ignition[1126]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:22:33.306515 ignition[1126]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:22:33.330265 ignition[1126]: PUT result: OK Nov 12 22:22:33.333873 ignition[1126]: parsed url from cmdline: "" Nov 12 22:22:33.334036 ignition[1126]: no config URL provided Nov 12 22:22:33.334059 ignition[1126]: reading system config file "/usr/lib/ignition/user.ign" Nov 12 22:22:33.335558 ignition[1126]: no config at "/usr/lib/ignition/user.ign" Nov 12 22:22:33.335616 ignition[1126]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:22:33.336452 ignition[1126]: PUT result: OK Nov 12 22:22:33.336577 ignition[1126]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Nov 12 22:22:33.340689 ignition[1126]: GET result: OK Nov 12 22:22:33.340805 ignition[1126]: parsing config with SHA512: 97e8a969244a0105f88ccad93a03b33f67d6412f924ab9e0a4ac26f8b3f399a26e812508d59f255498d49a0c7ddefde852e3f4a95f795c28eba6bb23c99ab7bd Nov 12 22:22:33.353057 unknown[1126]: fetched base config from "system" Nov 12 22:22:33.353344 ignition[1126]: fetch: fetch complete Nov 12 22:22:33.353074 unknown[1126]: fetched base config from "system" Nov 12 22:22:33.353355 ignition[1126]: fetch: fetch passed Nov 12 22:22:33.353088 unknown[1126]: fetched user config from "aws" Nov 12 22:22:33.353430 ignition[1126]: Ignition finished successfully Nov 12 22:22:33.365138 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Nov 12 22:22:33.376285 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 12 22:22:33.418599 ignition[1132]: Ignition 2.20.0 Nov 12 22:22:33.418638 ignition[1132]: Stage: kargs Nov 12 22:22:33.421902 ignition[1132]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:22:33.421943 ignition[1132]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:22:33.423619 ignition[1132]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:22:33.428105 ignition[1132]: PUT result: OK Nov 12 22:22:33.431810 ignition[1132]: kargs: kargs passed Nov 12 22:22:33.431951 ignition[1132]: Ignition finished successfully Nov 12 22:22:33.437094 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 12 22:22:33.449231 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 12 22:22:33.487969 ignition[1138]: Ignition 2.20.0 Nov 12 22:22:33.488001 ignition[1138]: Stage: disks Nov 12 22:22:33.489897 ignition[1138]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:22:33.489926 ignition[1138]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:22:33.490905 ignition[1138]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:22:33.492578 ignition[1138]: PUT result: OK Nov 12 22:22:33.501417 ignition[1138]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Nov 12 22:22:33.513680 ignition[1138]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Nov 12 22:22:33.513903 ignition[1138]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/nvme0n1p9" Nov 12 22:22:33.514491 ignition[1138]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Nov 12 22:22:33.557878 ignition[1138]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Nov 12 22:22:33.557913 ignition[1138]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "be7e07bb-77fc-4aec-a4f6-d76dc4498784" and label "ROOT" Nov 12 22:22:33.557925 ignition[1138]: disks: createFilesystems: filesystem at "/dev/disk/by-partlabel/ROOT" is already correctly formatted. Skipping mkfs... Nov 12 22:22:33.557957 ignition[1138]: disks: disks passed Nov 12 22:22:33.573852 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 12 22:22:33.558081 ignition[1138]: Ignition finished successfully Nov 12 22:22:33.581944 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 12 22:22:33.583082 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 12 22:22:33.585470 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 12 22:22:33.586423 systemd[1]: Reached target sysinit.target - System Initialization. Nov 12 22:22:33.586744 systemd[1]: Reached target basic.target - Basic System. Nov 12 22:22:33.613255 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 12 22:22:33.655993 systemd-fsck[1146]: ROOT: clean, 14/553520 files, 52654/553472 blocks Nov 12 22:22:33.662501 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 12 22:22:33.672131 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 12 22:22:33.772819 kernel: EXT4-fs (nvme0n1p9): mounted filesystem be7e07bb-77fc-4aec-a4f6-d76dc4498784 r/w with ordered data mode. Quota mode: none. Nov 12 22:22:33.774418 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 12 22:22:33.778074 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 12 22:22:33.796502 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 12 22:22:33.803270 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 12 22:22:33.807321 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 12 22:22:33.807545 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 12 22:22:33.807643 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 12 22:22:33.843532 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 12 22:22:33.849855 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by mount (1165) Nov 12 22:22:33.854848 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem e7e17182-4510-4c0b-82ae-ebdf6a7625d9 Nov 12 22:22:33.854946 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Nov 12 22:22:33.856339 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 12 22:22:33.857577 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 12 22:22:33.870860 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 12 22:22:33.874428 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 12 22:22:34.099029 systemd-networkd[1115]: eth0: Gained IPv6LL Nov 12 22:22:34.238130 initrd-setup-root[1189]: cut: /sysroot/etc/passwd: No such file or directory Nov 12 22:22:34.250101 initrd-setup-root[1196]: cut: /sysroot/etc/group: No such file or directory Nov 12 22:22:34.262243 initrd-setup-root[1203]: cut: /sysroot/etc/shadow: No such file or directory Nov 12 22:22:34.272622 initrd-setup-root[1210]: cut: /sysroot/etc/gshadow: No such file or directory Nov 12 22:22:34.569305 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 12 22:22:34.582030 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 12 22:22:34.592180 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 12 22:22:34.611984 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 12 22:22:34.615820 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem e7e17182-4510-4c0b-82ae-ebdf6a7625d9 Nov 12 22:22:34.656565 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 12 22:22:34.668973 ignition[1278]: INFO : Ignition 2.20.0 Nov 12 22:22:34.672588 ignition[1278]: INFO : Stage: mount Nov 12 22:22:34.672588 ignition[1278]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 22:22:34.672588 ignition[1278]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:22:34.672588 ignition[1278]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:22:34.680794 ignition[1278]: INFO : PUT result: OK Nov 12 22:22:34.685567 ignition[1278]: INFO : mount: op(1): [started] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Nov 12 22:22:34.689725 ignition[1278]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "ext4" "/dev/disk/by-partlabel/ROOT" "/sysroot/tmp/_translate-filesystem-0-ign1" Nov 12 22:22:34.695829 ignition[1278]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Nov 12 22:22:34.700094 ignition[1278]: INFO : mount: mount passed Nov 12 22:22:34.700094 ignition[1278]: INFO : Ignition finished successfully Nov 12 22:22:34.706918 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 12 22:22:34.724765 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 12 22:22:34.787114 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 12 22:22:34.812824 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/nvme0n1p6 scanned by mount (1291) Nov 12 22:22:34.816595 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem e7e17182-4510-4c0b-82ae-ebdf6a7625d9 Nov 12 22:22:34.816656 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Nov 12 22:22:34.816683 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 12 22:22:34.822826 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 12 22:22:34.827139 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 12 22:22:34.868349 ignition[1308]: INFO : Ignition 2.20.0 Nov 12 22:22:34.868349 ignition[1308]: INFO : Stage: files Nov 12 22:22:34.872009 ignition[1308]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 22:22:34.872009 ignition[1308]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:22:34.876274 ignition[1308]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:22:34.879252 ignition[1308]: INFO : PUT result: OK Nov 12 22:22:34.883109 ignition[1308]: DEBUG : files: compiled without relabeling support, skipping Nov 12 22:22:34.886221 ignition[1308]: INFO : files: createFilesystemsFiles: createFiles: op(1): [started] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Nov 12 22:22:34.886221 ignition[1308]: INFO : files: createFilesystemsFiles: createFiles: op(1): [finished] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Nov 12 22:22:34.886221 ignition[1308]: INFO : files: createResultFile: createFiles: op(2): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 12 22:22:34.886221 ignition[1308]: INFO : files: createResultFile: createFiles: op(2): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 12 22:22:34.886221 ignition[1308]: INFO : files: files passed Nov 12 22:22:34.886221 ignition[1308]: INFO : Ignition finished successfully Nov 12 22:22:34.899835 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 12 22:22:34.916181 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 12 22:22:34.929125 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 12 22:22:34.943763 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 12 22:22:34.946237 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 12 22:22:34.966547 initrd-setup-root-after-ignition[1328]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 12 22:22:34.966547 initrd-setup-root-after-ignition[1328]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 12 22:22:34.972869 initrd-setup-root-after-ignition[1332]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 12 22:22:34.977209 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 12 22:22:34.982951 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 12 22:22:34.996468 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 12 22:22:35.057831 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 12 22:22:35.059981 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 12 22:22:35.063544 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 12 22:22:35.065744 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 12 22:22:35.067915 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 12 22:22:35.093064 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 12 22:22:35.121477 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 12 22:22:35.139298 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 12 22:22:35.166487 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 12 22:22:35.169845 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 22:22:35.174872 systemd[1]: Stopped target timers.target - Timer Units. Nov 12 22:22:35.178975 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 12 22:22:35.179257 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 12 22:22:35.187275 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 12 22:22:35.189387 systemd[1]: Stopped target basic.target - Basic System. Nov 12 22:22:35.191313 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 12 22:22:35.198659 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 12 22:22:35.201452 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 12 22:22:35.206053 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 12 22:22:35.209284 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 12 22:22:35.211913 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 12 22:22:35.220582 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 12 22:22:35.223128 systemd[1]: Stopped target swap.target - Swaps. Nov 12 22:22:35.228176 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 12 22:22:35.228493 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 12 22:22:35.231836 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 12 22:22:35.239601 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 22:22:35.242082 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 12 22:22:35.244141 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 22:22:35.247707 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 12 22:22:35.247956 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 12 22:22:35.258578 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 12 22:22:35.259440 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 12 22:22:35.266194 systemd[1]: ignition-files.service: Deactivated successfully. Nov 12 22:22:35.266570 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 12 22:22:35.284542 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 12 22:22:35.286978 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 12 22:22:35.287247 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 22:22:35.297713 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 12 22:22:35.301193 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 12 22:22:35.301553 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 22:22:35.308704 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 12 22:22:35.308962 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 12 22:22:35.340939 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 12 22:22:35.343748 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 12 22:22:35.354882 ignition[1352]: INFO : Ignition 2.20.0 Nov 12 22:22:35.354882 ignition[1352]: INFO : Stage: umount Nov 12 22:22:35.358731 ignition[1352]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 22:22:35.358731 ignition[1352]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 12 22:22:35.358731 ignition[1352]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 12 22:22:35.366186 ignition[1352]: INFO : PUT result: OK Nov 12 22:22:35.371518 ignition[1352]: INFO : umount: op(1): [started] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Nov 12 22:22:35.377438 ignition[1352]: INFO : umount: op(1): [finished] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Nov 12 22:22:35.377438 ignition[1352]: INFO : umount: umount passed Nov 12 22:22:35.377438 ignition[1352]: INFO : Ignition finished successfully Nov 12 22:22:35.376488 systemd[1]: sysroot-tmp-_translate\x2dfilesystem\x2d0\x2dign1.mount: Deactivated successfully. Nov 12 22:22:35.377592 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 12 22:22:35.381860 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 12 22:22:35.386118 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 12 22:22:35.386253 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 12 22:22:35.390019 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 12 22:22:35.390118 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 12 22:22:35.397347 systemd[1]: ignition-fetch.service: Deactivated successfully. Nov 12 22:22:35.397538 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Nov 12 22:22:35.402371 systemd[1]: Stopped target network.target - Network. Nov 12 22:22:35.406691 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 12 22:22:35.407753 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 12 22:22:35.421361 systemd[1]: Stopped target paths.target - Path Units. Nov 12 22:22:35.423029 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 12 22:22:35.429010 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 22:22:35.431868 systemd[1]: Stopped target slices.target - Slice Units. Nov 12 22:22:35.435124 systemd[1]: Stopped target sockets.target - Socket Units. Nov 12 22:22:35.438939 systemd[1]: iscsid.socket: Deactivated successfully. Nov 12 22:22:35.444962 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 12 22:22:35.450034 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 12 22:22:35.450119 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 12 22:22:35.452401 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 12 22:22:35.452492 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 12 22:22:35.455893 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 12 22:22:35.456067 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 12 22:22:35.459040 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 12 22:22:35.465048 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 12 22:22:35.472331 systemd-networkd[1115]: eth0: DHCPv6 lease lost Nov 12 22:22:35.480552 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 12 22:22:35.485965 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 12 22:22:35.487825 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 12 22:22:35.494833 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 12 22:22:35.495446 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 12 22:22:35.502545 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 12 22:22:35.502765 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 12 22:22:35.507637 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 12 22:22:35.507743 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 12 22:22:35.512956 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 12 22:22:35.513065 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 12 22:22:35.529056 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 12 22:22:35.532628 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 12 22:22:35.532745 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 12 22:22:35.543559 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 12 22:22:35.543668 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 12 22:22:35.547589 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 12 22:22:35.547692 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 12 22:22:35.558242 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 12 22:22:35.558344 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 22:22:35.561304 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 22:22:35.586041 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 12 22:22:35.586670 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 12 22:22:35.594938 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 12 22:22:35.596838 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 22:22:35.601956 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 12 22:22:35.602043 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 12 22:22:35.604237 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 12 22:22:35.604433 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 22:22:35.608419 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 12 22:22:35.608586 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 12 22:22:35.612298 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 12 22:22:35.612386 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 12 22:22:35.614583 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 12 22:22:35.614663 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:22:35.638052 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 12 22:22:35.646645 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 12 22:22:35.648438 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 22:22:35.658944 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 12 22:22:35.659057 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:22:35.666087 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 12 22:22:35.666372 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 12 22:22:35.674354 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 12 22:22:35.692176 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 12 22:22:35.708000 systemd[1]: Switching root. Nov 12 22:22:35.753810 systemd-journald[252]: Received SIGTERM from PID 1 (systemd). Nov 12 22:22:35.753888 systemd-journald[252]: Journal stopped Nov 12 22:22:37.728322 kernel: SELinux: policy capability network_peer_controls=1 Nov 12 22:22:37.728465 kernel: SELinux: policy capability open_perms=1 Nov 12 22:22:37.728503 kernel: SELinux: policy capability extended_socket_class=1 Nov 12 22:22:37.728535 kernel: SELinux: policy capability always_check_network=0 Nov 12 22:22:37.728565 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 12 22:22:37.728594 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 12 22:22:37.728626 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 12 22:22:37.728656 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 12 22:22:37.728685 kernel: audit: type=1403 audit(1731450156.031:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 12 22:22:37.728728 systemd[1]: Successfully loaded SELinux policy in 53.816ms. Nov 12 22:22:37.728796 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 24.315ms. Nov 12 22:22:37.728836 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) Nov 12 22:22:37.728867 systemd[1]: Detected virtualization amazon. Nov 12 22:22:37.728898 systemd[1]: Detected architecture arm64. Nov 12 22:22:37.728931 systemd[1]: Detected first boot. Nov 12 22:22:37.728973 systemd[1]: Initializing machine ID from VM UUID. Nov 12 22:22:37.729002 zram_generator::config[1394]: No configuration found. Nov 12 22:22:37.729039 systemd[1]: Populated /etc with preset unit settings. Nov 12 22:22:37.729070 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 12 22:22:37.729104 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 12 22:22:37.729135 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 12 22:22:37.729167 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 12 22:22:37.729202 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 12 22:22:37.729234 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 12 22:22:37.729265 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 12 22:22:37.729298 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 12 22:22:37.729332 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 12 22:22:37.729362 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 12 22:22:37.729395 systemd[1]: Created slice user.slice - User and Session Slice. Nov 12 22:22:37.729424 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 22:22:37.729454 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 22:22:37.729483 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 12 22:22:37.729564 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 12 22:22:37.729612 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 12 22:22:37.729648 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 12 22:22:37.729682 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Nov 12 22:22:37.729726 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 22:22:37.729756 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 12 22:22:37.729817 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 12 22:22:37.729858 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 12 22:22:37.729890 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 12 22:22:37.729925 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 22:22:37.729958 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 12 22:22:37.729992 systemd[1]: Reached target slices.target - Slice Units. Nov 12 22:22:37.730027 systemd[1]: Reached target swap.target - Swaps. Nov 12 22:22:37.730057 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 12 22:22:37.730088 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 12 22:22:37.730121 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 12 22:22:37.730154 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 12 22:22:37.730183 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 22:22:37.730217 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 12 22:22:37.730250 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 12 22:22:37.730283 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 12 22:22:37.730312 systemd[1]: Mounting media.mount - External Media Directory... Nov 12 22:22:37.730343 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 12 22:22:37.730375 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 12 22:22:37.730407 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Nov 12 22:22:37.730436 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 12 22:22:37.730472 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). Nov 12 22:22:37.730502 systemd[1]: Reached target machines.target - Containers. Nov 12 22:22:37.730543 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 12 22:22:37.730576 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:22:37.730608 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 12 22:22:37.730638 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 12 22:22:37.730673 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 22:22:37.730702 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 12 22:22:37.730731 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 12 22:22:37.730764 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 12 22:22:37.730847 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 12 22:22:37.730880 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 12 22:22:37.730909 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 12 22:22:37.730938 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 12 22:22:37.730970 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 12 22:22:37.730999 systemd[1]: Stopped systemd-fsck-usr.service. Nov 12 22:22:37.731027 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 12 22:22:37.731063 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 12 22:22:37.731092 kernel: fuse: init (API version 7.39) Nov 12 22:22:37.731121 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 12 22:22:37.731149 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 12 22:22:37.731182 kernel: loop: module loaded Nov 12 22:22:37.731213 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 12 22:22:37.731245 systemd[1]: verity-setup.service: Deactivated successfully. Nov 12 22:22:37.731275 systemd[1]: Stopped verity-setup.service. Nov 12 22:22:37.731303 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 12 22:22:37.731338 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 12 22:22:37.731371 systemd[1]: Mounted media.mount - External Media Directory. Nov 12 22:22:37.731400 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 12 22:22:37.731430 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 12 22:22:37.731464 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 12 22:22:37.731502 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 22:22:37.731532 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 12 22:22:37.731562 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 12 22:22:37.731597 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 22:22:37.731627 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 22:22:37.731661 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 12 22:22:37.731696 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 12 22:22:37.731731 kernel: ACPI: bus type drm_connector registered Nov 12 22:22:37.731763 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 12 22:22:37.731876 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 12 22:22:37.732033 systemd-journald[1472]: Collecting audit messages is disabled. Nov 12 22:22:37.732097 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 12 22:22:37.732130 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 12 22:22:37.732166 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 12 22:22:37.732201 systemd-journald[1472]: Journal started Nov 12 22:22:37.732257 systemd-journald[1472]: Runtime Journal (/run/log/journal/ec214ffe235bcc518c15f43e13eaab4f) is 8.0M, max 75.3M, 67.3M free. Nov 12 22:22:37.169144 systemd[1]: Queued start job for default target multi-user.target. Nov 12 22:22:37.197969 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Nov 12 22:22:37.198911 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 12 22:22:37.734017 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 12 22:22:37.745927 systemd[1]: Started systemd-journald.service - Journal Service. Nov 12 22:22:37.747286 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 12 22:22:37.751086 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 12 22:22:37.772075 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 12 22:22:37.796749 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 12 22:22:37.808205 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 12 22:22:37.821050 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 12 22:22:37.825967 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 12 22:22:37.826042 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 12 22:22:37.832432 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Nov 12 22:22:37.846803 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 12 22:22:37.854431 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 12 22:22:37.857849 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:22:37.861895 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 12 22:22:37.868292 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 12 22:22:37.872195 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 12 22:22:37.877300 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 12 22:22:37.880058 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 12 22:22:37.882484 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 12 22:22:37.897212 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 22:22:37.905148 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 12 22:22:37.908530 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 12 22:22:37.935378 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 12 22:22:37.956912 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 12 22:22:37.976183 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 12 22:22:38.018688 systemd-journald[1472]: Time spent on flushing to /var/log/journal/ec214ffe235bcc518c15f43e13eaab4f is 44.862ms for 890 entries. Nov 12 22:22:38.018688 systemd-journald[1472]: System Journal (/var/log/journal/ec214ffe235bcc518c15f43e13eaab4f) is 8.0M, max 195.6M, 187.6M free. Nov 12 22:22:38.082863 kernel: loop0: detected capacity change from 0 to 113536 Nov 12 22:22:38.082940 systemd-journald[1472]: Received client request to flush runtime journal. Nov 12 22:22:38.025942 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 12 22:22:38.028744 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 12 22:22:38.037214 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Nov 12 22:22:38.101934 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 12 22:22:38.115088 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 12 22:22:38.125814 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 12 22:22:38.172535 kernel: loop1: detected capacity change from 0 to 116808 Nov 12 22:22:38.176172 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 12 22:22:38.183487 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Nov 12 22:22:38.211029 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 22:22:38.226132 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Nov 12 22:22:38.229879 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 12 22:22:38.242274 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 12 22:22:38.269513 udevadm[1541]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Nov 12 22:22:38.304837 kernel: loop2: detected capacity change from 0 to 53784 Nov 12 22:22:38.365002 systemd-tmpfiles[1543]: ACLs are not supported, ignoring. Nov 12 22:22:38.365043 systemd-tmpfiles[1543]: ACLs are not supported, ignoring. Nov 12 22:22:38.385097 kernel: loop3: detected capacity change from 0 to 113536 Nov 12 22:22:38.395000 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 22:22:38.413990 kernel: loop4: detected capacity change from 0 to 116808 Nov 12 22:22:38.434852 kernel: loop5: detected capacity change from 0 to 53784 Nov 12 22:22:38.464030 (sd-merge)[1547]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Nov 12 22:22:38.470736 (sd-merge)[1547]: Merged extensions into '/usr'. Nov 12 22:22:38.477863 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 22:22:38.492041 systemd[1]: Starting ensure-sysext.service... Nov 12 22:22:38.502603 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 12 22:22:38.531627 systemd[1]: Reloading requested from client PID 1550 ('systemctl') (unit ensure-sysext.service)... Nov 12 22:22:38.531667 systemd[1]: Reloading... Nov 12 22:22:38.604041 systemd-tmpfiles[1551]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 12 22:22:38.604706 systemd-tmpfiles[1551]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 12 22:22:38.608128 systemd-tmpfiles[1551]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 12 22:22:38.608696 systemd-tmpfiles[1551]: ACLs are not supported, ignoring. Nov 12 22:22:38.609679 systemd-tmpfiles[1551]: ACLs are not supported, ignoring. Nov 12 22:22:38.620161 systemd-tmpfiles[1551]: Detected autofs mount point /boot during canonicalization of boot. Nov 12 22:22:38.620197 systemd-tmpfiles[1551]: Skipping /boot Nov 12 22:22:38.652552 systemd-tmpfiles[1551]: Detected autofs mount point /boot during canonicalization of boot. Nov 12 22:22:38.652592 systemd-tmpfiles[1551]: Skipping /boot Nov 12 22:22:38.802287 zram_generator::config[1582]: No configuration found. Nov 12 22:22:39.077897 ldconfig[1514]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 12 22:22:39.148031 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. Nov 12 22:22:39.258298 systemd[1]: Reloading finished in 725 ms. Nov 12 22:22:39.295980 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 12 22:22:39.299365 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 22:22:39.336365 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 12 22:22:39.348289 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 12 22:22:39.362512 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 12 22:22:39.381286 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 12 22:22:39.395595 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 12 22:22:39.419655 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:22:39.426495 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 22:22:39.456043 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 12 22:22:39.462353 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 12 22:22:39.466304 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:22:39.472447 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:22:39.472865 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:22:39.480200 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:22:39.485319 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 12 22:22:39.487509 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:22:39.487891 systemd[1]: Reached target time-set.target - System Time Set. Nov 12 22:22:39.507588 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 12 22:22:39.512248 systemd[1]: Finished ensure-sysext.service. Nov 12 22:22:39.521209 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 12 22:22:39.592617 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 12 22:22:39.596976 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 12 22:22:39.600230 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 12 22:22:39.607936 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 12 22:22:39.620620 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 22:22:39.621924 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 22:22:39.627233 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 12 22:22:39.627618 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 12 22:22:39.633637 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 12 22:22:39.641561 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 12 22:22:39.642066 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 12 22:22:39.694928 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 12 22:22:39.699317 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). Nov 12 22:22:39.713230 augenrules[1670]: No rules Nov 12 22:22:39.715924 systemd[1]: audit-rules.service: Deactivated successfully. Nov 12 22:22:39.716386 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 12 22:22:39.726274 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 12 22:22:39.807093 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 12 22:22:39.820283 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 22:22:39.836378 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 12 22:22:39.861744 systemd-resolved[1636]: Positive Trust Anchors: Nov 12 22:22:39.861826 systemd-resolved[1636]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 12 22:22:39.861891 systemd-resolved[1636]: 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 Nov 12 22:22:39.876035 systemd-resolved[1636]: Defaulting to hostname 'linux'. Nov 12 22:22:39.883050 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 12 22:22:39.885401 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 12 22:22:39.891898 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 12 22:22:39.915934 systemd-udevd[1682]: Using default interface naming scheme 'v255'. Nov 12 22:22:39.956121 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 22:22:39.969130 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 12 22:22:40.115293 (udev-worker)[1702]: Network interface NamePolicy= disabled on kernel command line. Nov 12 22:22:40.156295 systemd-networkd[1687]: lo: Link UP Nov 12 22:22:40.157918 systemd-networkd[1687]: lo: Gained carrier Nov 12 22:22:40.160700 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Nov 12 22:22:40.163804 systemd-networkd[1687]: Enumeration completed Nov 12 22:22:40.164197 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 12 22:22:40.166547 systemd[1]: Reached target network.target - Network. Nov 12 22:22:40.169176 systemd-networkd[1687]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:22:40.169309 systemd-networkd[1687]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 12 22:22:40.172196 systemd-networkd[1687]: eth0: Link UP Nov 12 22:22:40.172499 systemd-networkd[1687]: eth0: Gained carrier Nov 12 22:22:40.172532 systemd-networkd[1687]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:22:40.179600 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 12 22:22:40.185930 systemd-networkd[1687]: eth0: DHCPv4 address 172.31.22.251/20, gateway 172.31.16.1 acquired from 172.31.16.1 Nov 12 22:22:40.220889 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1705) Nov 12 22:22:40.229821 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1705) Nov 12 22:22:40.239000 systemd-networkd[1687]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:22:40.294841 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (1701) Nov 12 22:22:40.577496 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:22:40.586622 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Nov 12 22:22:40.596746 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 12 22:22:40.622368 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Nov 12 22:22:40.637085 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Nov 12 22:22:40.659094 lvm[1805]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 12 22:22:40.667951 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 12 22:22:40.706731 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Nov 12 22:22:40.710472 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 12 22:22:40.722123 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Nov 12 22:22:40.746033 lvm[1811]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 12 22:22:40.745877 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:22:40.748722 systemd[1]: Reached target sysinit.target - System Initialization. Nov 12 22:22:40.751853 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 12 22:22:40.767544 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 12 22:22:40.770392 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 12 22:22:40.772759 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 12 22:22:40.775228 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 12 22:22:40.779613 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 12 22:22:40.779691 systemd[1]: Reached target paths.target - Path Units. Nov 12 22:22:40.781619 systemd[1]: Reached target timers.target - Timer Units. Nov 12 22:22:40.785240 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 12 22:22:40.790605 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 12 22:22:40.809118 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 12 22:22:40.812848 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Nov 12 22:22:40.816454 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 12 22:22:40.820224 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 22:22:40.822375 systemd[1]: Reached target basic.target - Basic System. Nov 12 22:22:40.824422 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 12 22:22:40.824497 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 12 22:22:40.836176 systemd[1]: Starting containerd.service - containerd container runtime... Nov 12 22:22:40.843762 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Nov 12 22:22:40.853317 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 12 22:22:40.858474 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 12 22:22:40.868654 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 12 22:22:40.870882 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). Nov 12 22:22:40.875923 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 12 22:22:40.888230 systemd[1]: Started ntpd.service - Network Time Service. Nov 12 22:22:40.906313 systemd[1]: Starting setup-oem.service - Setup OEM... Nov 12 22:22:40.911559 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 12 22:22:40.922292 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 12 22:22:40.951198 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 12 22:22:40.954361 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 12 22:22:40.955380 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 12 22:22:40.975131 systemd[1]: Starting update-engine.service - Update Engine... Nov 12 22:22:40.988423 jq[1820]: false Nov 12 22:22:40.990353 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 12 22:22:41.004659 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 12 22:22:41.005418 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 12 22:22:41.011920 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 12 22:22:41.014938 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 12 22:22:41.072275 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 12 22:22:41.097932 jq[1831]: true Nov 12 22:22:41.099725 systemd[1]: motdgen.service: Deactivated successfully. Nov 12 22:22:41.101517 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 12 22:22:41.110185 update_engine[1830]: I20241112 22:22:41.105755 1830 main.cc:92] Flatcar Update Engine starting Nov 12 22:22:41.136301 ntpd[1823]: ntpd 4.2.8p17@1.4004-o Tue Nov 12 20:41:47 UTC 2024 (1): Starting Nov 12 22:22:41.143479 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: ntpd 4.2.8p17@1.4004-o Tue Nov 12 20:41:47 UTC 2024 (1): Starting Nov 12 22:22:41.143479 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Nov 12 22:22:41.143479 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: ---------------------------------------------------- Nov 12 22:22:41.143479 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: ntp-4 is maintained by Network Time Foundation, Nov 12 22:22:41.143479 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Nov 12 22:22:41.143479 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: corporation. Support and training for ntp-4 are Nov 12 22:22:41.143479 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: available at https://www.nwtime.org/support Nov 12 22:22:41.143479 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: ---------------------------------------------------- Nov 12 22:22:41.143479 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: proto: precision = 0.096 usec (-23) Nov 12 22:22:41.136373 ntpd[1823]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Nov 12 22:22:41.144576 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: basedate set to 2024-10-31 Nov 12 22:22:41.144576 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: gps base set to 2024-11-03 (week 2339) Nov 12 22:22:41.136393 ntpd[1823]: ---------------------------------------------------- Nov 12 22:22:41.136412 ntpd[1823]: ntp-4 is maintained by Network Time Foundation, Nov 12 22:22:41.136430 ntpd[1823]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Nov 12 22:22:41.156177 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: Listen and drop on 0 v6wildcard [::]:123 Nov 12 22:22:41.156177 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 12 22:22:41.156177 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: Listen normally on 2 lo 127.0.0.1:123 Nov 12 22:22:41.156177 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: Listen normally on 3 eth0 172.31.22.251:123 Nov 12 22:22:41.156177 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: Listen normally on 4 lo [::1]:123 Nov 12 22:22:41.156177 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: bind(21) AF_INET6 fe80::4ad:d5ff:fea0:b0d%2#123 flags 0x11 failed: Cannot assign requested address Nov 12 22:22:41.156177 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: unable to create socket on eth0 (5) for fe80::4ad:d5ff:fea0:b0d%2#123 Nov 12 22:22:41.156177 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: failed to init interface for address fe80::4ad:d5ff:fea0:b0d%2 Nov 12 22:22:41.156177 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: Listening on routing socket on fd #21 for interface updates Nov 12 22:22:41.136450 ntpd[1823]: corporation. Support and training for ntp-4 are Nov 12 22:22:41.136468 ntpd[1823]: available at https://www.nwtime.org/support Nov 12 22:22:41.136485 ntpd[1823]: ---------------------------------------------------- Nov 12 22:22:41.143248 ntpd[1823]: proto: precision = 0.096 usec (-23) Nov 12 22:22:41.143664 ntpd[1823]: basedate set to 2024-10-31 Nov 12 22:22:41.143688 ntpd[1823]: gps base set to 2024-11-03 (week 2339) Nov 12 22:22:41.148546 ntpd[1823]: Listen and drop on 0 v6wildcard [::]:123 Nov 12 22:22:41.148729 ntpd[1823]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 12 22:22:41.151604 ntpd[1823]: Listen normally on 2 lo 127.0.0.1:123 Nov 12 22:22:41.151749 ntpd[1823]: Listen normally on 3 eth0 172.31.22.251:123 Nov 12 22:22:41.151858 ntpd[1823]: Listen normally on 4 lo [::1]:123 Nov 12 22:22:41.151951 ntpd[1823]: bind(21) AF_INET6 fe80::4ad:d5ff:fea0:b0d%2#123 flags 0x11 failed: Cannot assign requested address Nov 12 22:22:41.152010 ntpd[1823]: unable to create socket on eth0 (5) for fe80::4ad:d5ff:fea0:b0d%2#123 Nov 12 22:22:41.166579 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 12 22:22:41.198626 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 12 22:22:41.198626 ntpd[1823]: 12 Nov 22:22:41 ntpd[1823]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 12 22:22:41.152040 ntpd[1823]: failed to init interface for address fe80::4ad:d5ff:fea0:b0d%2 Nov 12 22:22:41.198945 update_engine[1830]: I20241112 22:22:41.191720 1830 update_check_scheduler.cc:74] Next update check in 7m56s Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.180 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.185 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.185 INFO Fetch successful Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.185 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.185 INFO Fetch successful Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.185 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.185 INFO Fetch successful Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.185 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetch successful Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetch failed with 404: resource not found Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetch successful Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetch successful Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetch successful Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetch successful Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.186 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Nov 12 22:22:41.199055 coreos-metadata[1818]: Nov 12 22:22:41.197 INFO Fetch successful Nov 12 22:22:41.180163 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). Nov 12 22:22:41.152095 ntpd[1823]: Listening on routing socket on fd #21 for interface updates Nov 12 22:22:41.233429 extend-filesystems[1821]: Found loop3 Nov 12 22:22:41.233429 extend-filesystems[1821]: Found loop4 Nov 12 22:22:41.233429 extend-filesystems[1821]: Found loop5 Nov 12 22:22:41.233429 extend-filesystems[1821]: Found nvme0n1 Nov 12 22:22:41.233429 extend-filesystems[1821]: Found nvme0n1p2 Nov 12 22:22:41.233429 extend-filesystems[1821]: Found nvme0n1p3 Nov 12 22:22:41.233429 extend-filesystems[1821]: Found usr Nov 12 22:22:41.233429 extend-filesystems[1821]: Found nvme0n1p4 Nov 12 22:22:41.233429 extend-filesystems[1821]: Found nvme0n1p6 Nov 12 22:22:41.233429 extend-filesystems[1821]: Found nvme0n1p7 Nov 12 22:22:41.233429 extend-filesystems[1821]: Found nvme0n1p9 Nov 12 22:22:41.233429 extend-filesystems[1821]: Checking size of /dev/nvme0n1p9 Nov 12 22:22:41.180228 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 12 22:22:41.160496 ntpd[1823]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 12 22:22:41.298064 jq[1851]: true Nov 12 22:22:41.183058 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). Nov 12 22:22:41.160550 ntpd[1823]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 12 22:22:41.316753 extend-filesystems[1821]: Resized partition /dev/nvme0n1p9 Nov 12 22:22:41.183096 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 12 22:22:41.165619 dbus-daemon[1819]: [system] SELinux support is enabled Nov 12 22:22:41.325628 extend-filesystems[1869]: resize2fs 1.47.1 (20-May-2024) Nov 12 22:22:41.355009 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Nov 12 22:22:41.191904 systemd[1]: Started update-engine.service - Update Engine. Nov 12 22:22:41.186147 dbus-daemon[1819]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1687 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Nov 12 22:22:41.196894 (ntainerd)[1845]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Nov 12 22:22:41.187590 dbus-daemon[1819]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 12 22:22:41.210400 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Nov 12 22:22:41.221193 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 12 22:22:41.420315 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Nov 12 22:22:41.422876 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 12 22:22:41.427906 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 12 22:22:41.444413 systemd[1]: Starting sshkeys.service... Nov 12 22:22:41.453379 systemd[1]: Finished setup-oem.service - Setup OEM. Nov 12 22:22:41.479513 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Nov 12 22:22:41.519932 systemd-logind[1829]: Watching system buttons on /dev/input/event0 (Power Button) Nov 12 22:22:41.519969 systemd-logind[1829]: Watching system buttons on /dev/input/event1 (Sleep Button) Nov 12 22:22:41.522128 extend-filesystems[1869]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Nov 12 22:22:41.522128 extend-filesystems[1869]: old_desc_blocks = 1, new_desc_blocks = 1 Nov 12 22:22:41.522128 extend-filesystems[1869]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Nov 12 22:22:41.552262 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (1691) Nov 12 22:22:41.521298 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Nov 12 22:22:41.552445 extend-filesystems[1821]: Resized filesystem in /dev/nvme0n1p9 Nov 12 22:22:41.552445 extend-filesystems[1821]: Found nvme0n1p1 Nov 12 22:22:41.524122 systemd-logind[1829]: New seat seat0. Nov 12 22:22:41.603689 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Nov 12 22:22:41.607325 systemd[1]: Started systemd-logind.service - User Login Management. Nov 12 22:22:41.610449 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 12 22:22:41.611073 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 12 22:22:41.747448 dbus-daemon[1819]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 12 22:22:41.747742 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Nov 12 22:22:41.757314 dbus-daemon[1819]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1858 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Nov 12 22:22:41.802479 systemd[1]: Starting polkit.service - Authorization Manager... Nov 12 22:22:41.846190 systemd-networkd[1687]: eth0: Gained IPv6LL Nov 12 22:22:41.847737 polkitd[1944]: Started polkitd version 121 Nov 12 22:22:41.860111 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 12 22:22:41.863999 systemd[1]: Reached target network-online.target - Network is Online. Nov 12 22:22:41.866569 coreos-metadata[1900]: Nov 12 22:22:41.866 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Nov 12 22:22:41.866569 coreos-metadata[1900]: Nov 12 22:22:41.866 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Nov 12 22:22:41.866569 coreos-metadata[1900]: Nov 12 22:22:41.866 INFO Fetch successful Nov 12 22:22:41.866569 coreos-metadata[1900]: Nov 12 22:22:41.866 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Nov 12 22:22:41.874098 coreos-metadata[1900]: Nov 12 22:22:41.867 INFO Fetch successful Nov 12 22:22:41.875388 unknown[1900]: wrote ssh authorized keys file for user: core Nov 12 22:22:41.878614 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Nov 12 22:22:41.895542 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 12 22:22:41.946282 locksmithd[1859]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 12 22:22:41.947661 polkitd[1944]: Loading rules from directory /etc/polkit-1/rules.d Nov 12 22:22:41.980424 containerd[1845]: time="2024-11-12T22:22:41.958332310Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Nov 12 22:22:41.947817 polkitd[1944]: Loading rules from directory /usr/share/polkit-1/rules.d Nov 12 22:22:41.979884 polkitd[1944]: Finished loading, compiling and executing 2 rules Nov 12 22:22:41.985972 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Nov 12 22:22:41.989735 update-ssh-keys[1966]: Updated "/home/core/.ssh/authorized_keys" Nov 12 22:22:41.990714 dbus-daemon[1819]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 12 22:22:41.991902 systemd[1]: Started polkit.service - Authorization Manager. Nov 12 22:22:41.997005 polkitd[1944]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Nov 12 22:22:42.003892 systemd[1]: Finished sshkeys.service. Nov 12 22:22:42.080021 systemd-hostnamed[1858]: Hostname set to (transient) Nov 12 22:22:42.082853 systemd-resolved[1636]: System hostname changed to 'ip-172-31-22-251'. Nov 12 22:22:42.131705 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 12 22:22:42.201816 amazon-ssm-agent[1959]: Initializing new seelog logger Nov 12 22:22:42.201816 amazon-ssm-agent[1959]: New Seelog Logger Creation Complete Nov 12 22:22:42.201816 amazon-ssm-agent[1959]: 2024/11/12 22:22:42 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:22:42.201816 amazon-ssm-agent[1959]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:22:42.202462 containerd[1845]: time="2024-11-12T22:22:42.200728928Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:22:42.202660 amazon-ssm-agent[1959]: 2024/11/12 22:22:42 processing appconfig overrides Nov 12 22:22:42.208819 amazon-ssm-agent[1959]: 2024/11/12 22:22:42 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:22:42.208819 amazon-ssm-agent[1959]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:22:42.208819 amazon-ssm-agent[1959]: 2024/11/12 22:22:42 processing appconfig overrides Nov 12 22:22:42.208819 amazon-ssm-agent[1959]: 2024/11/12 22:22:42 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:22:42.208819 amazon-ssm-agent[1959]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:22:42.208819 amazon-ssm-agent[1959]: 2024/11/12 22:22:42 processing appconfig overrides Nov 12 22:22:42.208819 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO Proxy environment variables: Nov 12 22:22:42.215065 amazon-ssm-agent[1959]: 2024/11/12 22:22:42 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:22:42.215065 amazon-ssm-agent[1959]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 12 22:22:42.215065 amazon-ssm-agent[1959]: 2024/11/12 22:22:42 processing appconfig overrides Nov 12 22:22:42.217809 containerd[1845]: time="2024-11-12T22:22:42.216111188Z" 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.60-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 12 22:22:42.217809 containerd[1845]: time="2024-11-12T22:22:42.216184004Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Nov 12 22:22:42.217809 containerd[1845]: time="2024-11-12T22:22:42.216223496Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 12 22:22:42.217809 containerd[1845]: time="2024-11-12T22:22:42.216554576Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Nov 12 22:22:42.217809 containerd[1845]: time="2024-11-12T22:22:42.216588260Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Nov 12 22:22:42.217809 containerd[1845]: time="2024-11-12T22:22:42.216709628Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Nov 12 22:22:42.217809 containerd[1845]: time="2024-11-12T22:22:42.216737372Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:22:42.222263 containerd[1845]: time="2024-11-12T22:22:42.222182300Z" 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 Nov 12 22:22:42.222263 containerd[1845]: time="2024-11-12T22:22:42.222249056Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 12 22:22:42.222445 containerd[1845]: time="2024-11-12T22:22:42.222287408Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Nov 12 22:22:42.222445 containerd[1845]: time="2024-11-12T22:22:42.222312680Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 12 22:22:42.222533 containerd[1845]: time="2024-11-12T22:22:42.222499724Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:22:42.224942 containerd[1845]: time="2024-11-12T22:22:42.223044680Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:22:42.224942 containerd[1845]: time="2024-11-12T22:22:42.223274540Z" 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 Nov 12 22:22:42.224942 containerd[1845]: time="2024-11-12T22:22:42.223306028Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 12 22:22:42.229186 containerd[1845]: time="2024-11-12T22:22:42.229113656Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 12 22:22:42.229375 containerd[1845]: time="2024-11-12T22:22:42.229334624Z" level=info msg="metadata content store policy set" policy=shared Nov 12 22:22:42.238601 containerd[1845]: time="2024-11-12T22:22:42.238472720Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 12 22:22:42.238601 containerd[1845]: time="2024-11-12T22:22:42.238646132Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 12 22:22:42.239267 containerd[1845]: time="2024-11-12T22:22:42.238689836Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Nov 12 22:22:42.239267 containerd[1845]: time="2024-11-12T22:22:42.238732484Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Nov 12 22:22:42.239267 containerd[1845]: time="2024-11-12T22:22:42.238798172Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 12 22:22:42.239267 containerd[1845]: time="2024-11-12T22:22:42.239233364Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.239719736Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240100280Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240141140Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240176324Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240207980Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240240044Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240268808Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240300032Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240331328Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240362948Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240392948Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240421124Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240473600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.242977 containerd[1845]: time="2024-11-12T22:22:42.240506084Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240535184Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240567056Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240596852Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240627584Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240658940Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240689744Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240721976Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240758804Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240812768Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240850160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240887564Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.240926912Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.241004612Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.241044104Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.243581 containerd[1845]: time="2024-11-12T22:22:42.241077128Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 12 22:22:42.248365 containerd[1845]: time="2024-11-12T22:22:42.241297652Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Nov 12 22:22:42.248365 containerd[1845]: time="2024-11-12T22:22:42.241349276Z" 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 Nov 12 22:22:42.248365 containerd[1845]: time="2024-11-12T22:22:42.241380800Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Nov 12 22:22:42.248365 containerd[1845]: time="2024-11-12T22:22:42.241413032Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Nov 12 22:22:42.248365 containerd[1845]: time="2024-11-12T22:22:42.241436384Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.248365 containerd[1845]: time="2024-11-12T22:22:42.241473380Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Nov 12 22:22:42.248365 containerd[1845]: time="2024-11-12T22:22:42.241501340Z" level=info msg="NRI interface is disabled by configuration." Nov 12 22:22:42.248365 containerd[1845]: time="2024-11-12T22:22:42.241528904Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Nov 12 22:22:42.251324 containerd[1845]: time="2024-11-12T22:22:42.250559588Z" 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}" Nov 12 22:22:42.251324 containerd[1845]: time="2024-11-12T22:22:42.251229200Z" level=info msg="Connect containerd service" Nov 12 22:22:42.256172 containerd[1845]: time="2024-11-12T22:22:42.251712800Z" level=info msg="using legacy CRI server" Nov 12 22:22:42.256172 containerd[1845]: time="2024-11-12T22:22:42.253862528Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 12 22:22:42.256172 containerd[1845]: time="2024-11-12T22:22:42.254268320Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Nov 12 22:22:42.262555 containerd[1845]: time="2024-11-12T22:22:42.262455104Z" 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" Nov 12 22:22:42.263152 containerd[1845]: time="2024-11-12T22:22:42.263069096Z" level=info msg="Start subscribing containerd event" Nov 12 22:22:42.263237 containerd[1845]: time="2024-11-12T22:22:42.263182760Z" level=info msg="Start recovering state" Nov 12 22:22:42.264687 containerd[1845]: time="2024-11-12T22:22:42.263339336Z" level=info msg="Start event monitor" Nov 12 22:22:42.264687 containerd[1845]: time="2024-11-12T22:22:42.263377880Z" level=info msg="Start snapshots syncer" Nov 12 22:22:42.264687 containerd[1845]: time="2024-11-12T22:22:42.263408528Z" level=info msg="Start cni network conf syncer for default" Nov 12 22:22:42.264687 containerd[1845]: time="2024-11-12T22:22:42.263431424Z" level=info msg="Start streaming server" Nov 12 22:22:42.264687 containerd[1845]: time="2024-11-12T22:22:42.263956316Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 12 22:22:42.264687 containerd[1845]: time="2024-11-12T22:22:42.264107708Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 12 22:22:42.264496 systemd[1]: Started containerd.service - containerd container runtime. Nov 12 22:22:42.271809 containerd[1845]: time="2024-11-12T22:22:42.269880908Z" level=info msg="containerd successfully booted in 0.315829s" Nov 12 22:22:42.312826 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO http_proxy: Nov 12 22:22:42.336075 sshd_keygen[1863]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 12 22:22:42.384917 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 12 22:22:42.399885 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 12 22:22:42.410054 systemd[1]: Started sshd@0-172.31.22.251:22-147.75.109.163:48510.service - OpenSSH per-connection server daemon (147.75.109.163:48510). Nov 12 22:22:42.415200 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO no_proxy: Nov 12 22:22:42.431070 systemd[1]: issuegen.service: Deactivated successfully. Nov 12 22:22:42.432254 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 12 22:22:42.450487 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 12 22:22:42.495506 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 12 22:22:42.511466 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 12 22:22:42.514042 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO https_proxy: Nov 12 22:22:42.526237 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Nov 12 22:22:42.528922 systemd[1]: Reached target getty.target - Login Prompts. Nov 12 22:22:42.531135 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 12 22:22:42.538892 systemd[1]: Startup finished in 1.153s (kernel) + 7.222s (initrd) + 6.559s (userspace) = 14.935s. Nov 12 22:22:42.612079 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO Checking if agent identity type OnPrem can be assumed Nov 12 22:22:42.663900 sshd[2040]: Accepted publickey for core from 147.75.109.163 port 48510 ssh2: RSA SHA256:uIlZGZS4ktpZyIP4/chqTIlyFelgeTnlXR9XFJx/YBs Nov 12 22:22:42.666073 sshd-session[2040]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:22:42.685272 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 12 22:22:42.699072 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 12 22:22:42.703751 systemd-logind[1829]: New session 1 of user core. Nov 12 22:22:42.710900 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO Checking if agent identity type EC2 can be assumed Nov 12 22:22:42.734061 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 12 22:22:42.747443 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 12 22:22:42.765013 (systemd)[2057]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 12 22:22:42.811547 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO Agent will take identity from EC2 Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [amazon-ssm-agent] using named pipe channel for IPC Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [amazon-ssm-agent] using named pipe channel for IPC Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [amazon-ssm-agent] using named pipe channel for IPC Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [amazon-ssm-agent] Starting Core Agent Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [amazon-ssm-agent] registrar detected. Attempting registration Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [Registrar] Starting registrar module Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [EC2Identity] EC2 registration was successful. Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [CredentialRefresher] credentialRefresher has started Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [CredentialRefresher] Starting credentials refresher loop Nov 12 22:22:42.887916 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO EC2RoleProvider Successfully connected with instance profile role credentials Nov 12 22:22:42.910254 amazon-ssm-agent[1959]: 2024-11-12 22:22:42 INFO [CredentialRefresher] Next credential rotation will be in 30.924988837 minutes Nov 12 22:22:42.999602 systemd[2057]: Queued start job for default target default.target. Nov 12 22:22:43.008075 systemd[2057]: Created slice app.slice - User Application Slice. Nov 12 22:22:43.008148 systemd[2057]: Reached target paths.target - Paths. Nov 12 22:22:43.008182 systemd[2057]: Reached target timers.target - Timers. Nov 12 22:22:43.013176 systemd[2057]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 12 22:22:43.049157 systemd[2057]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 12 22:22:43.051070 systemd[2057]: Reached target sockets.target - Sockets. Nov 12 22:22:43.051125 systemd[2057]: Reached target basic.target - Basic System. Nov 12 22:22:43.051226 systemd[2057]: Reached target default.target - Main User Target. Nov 12 22:22:43.051292 systemd[2057]: Startup finished in 271ms. Nov 12 22:22:43.051488 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 12 22:22:43.061079 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 12 22:22:43.218413 systemd[1]: Started sshd@1-172.31.22.251:22-147.75.109.163:48524.service - OpenSSH per-connection server daemon (147.75.109.163:48524). Nov 12 22:22:43.410991 sshd[2069]: Accepted publickey for core from 147.75.109.163 port 48524 ssh2: RSA SHA256:uIlZGZS4ktpZyIP4/chqTIlyFelgeTnlXR9XFJx/YBs Nov 12 22:22:43.414047 sshd-session[2069]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:22:43.423524 systemd-logind[1829]: New session 2 of user core. Nov 12 22:22:43.436191 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 12 22:22:43.563879 sshd[2071]: Connection closed by 147.75.109.163 port 48524 Nov 12 22:22:43.565059 sshd-session[2069]: pam_unix(sshd:session): session closed for user core Nov 12 22:22:43.580598 systemd[1]: sshd@1-172.31.22.251:22-147.75.109.163:48524.service: Deactivated successfully. Nov 12 22:22:43.585032 systemd[1]: session-2.scope: Deactivated successfully. Nov 12 22:22:43.587366 systemd-logind[1829]: Session 2 logged out. Waiting for processes to exit. Nov 12 22:22:43.616379 systemd[1]: Started sshd@2-172.31.22.251:22-147.75.109.163:48540.service - OpenSSH per-connection server daemon (147.75.109.163:48540). Nov 12 22:22:43.618709 systemd-logind[1829]: Removed session 2. Nov 12 22:22:43.797812 sshd[2076]: Accepted publickey for core from 147.75.109.163 port 48540 ssh2: RSA SHA256:uIlZGZS4ktpZyIP4/chqTIlyFelgeTnlXR9XFJx/YBs Nov 12 22:22:43.800319 sshd-session[2076]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:22:43.808847 systemd-logind[1829]: New session 3 of user core. Nov 12 22:22:43.816085 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 12 22:22:43.917654 amazon-ssm-agent[1959]: 2024-11-12 22:22:43 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Nov 12 22:22:43.939205 sshd[2078]: Connection closed by 147.75.109.163 port 48540 Nov 12 22:22:43.941108 sshd-session[2076]: pam_unix(sshd:session): session closed for user core Nov 12 22:22:43.951624 systemd[1]: sshd@2-172.31.22.251:22-147.75.109.163:48540.service: Deactivated successfully. Nov 12 22:22:43.957405 systemd[1]: session-3.scope: Deactivated successfully. Nov 12 22:22:43.959476 systemd-logind[1829]: Session 3 logged out. Waiting for processes to exit. Nov 12 22:22:43.987124 systemd[1]: Started sshd@3-172.31.22.251:22-147.75.109.163:48546.service - OpenSSH per-connection server daemon (147.75.109.163:48546). Nov 12 22:22:43.989754 systemd-logind[1829]: Removed session 3. Nov 12 22:22:44.021820 amazon-ssm-agent[1959]: 2024-11-12 22:22:43 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2081) started Nov 12 22:22:44.121377 amazon-ssm-agent[1959]: 2024-11-12 22:22:43 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Nov 12 22:22:44.137207 ntpd[1823]: Listen normally on 6 eth0 [fe80::4ad:d5ff:fea0:b0d%2]:123 Nov 12 22:22:44.139654 ntpd[1823]: 12 Nov 22:22:44 ntpd[1823]: Listen normally on 6 eth0 [fe80::4ad:d5ff:fea0:b0d%2]:123 Nov 12 22:22:44.203171 sshd[2088]: Accepted publickey for core from 147.75.109.163 port 48546 ssh2: RSA SHA256:uIlZGZS4ktpZyIP4/chqTIlyFelgeTnlXR9XFJx/YBs Nov 12 22:22:44.205772 sshd-session[2088]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:22:44.213364 systemd-logind[1829]: New session 4 of user core. Nov 12 22:22:44.224066 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 12 22:22:44.354492 sshd[2095]: Connection closed by 147.75.109.163 port 48546 Nov 12 22:22:44.355494 sshd-session[2088]: pam_unix(sshd:session): session closed for user core Nov 12 22:22:44.363115 systemd[1]: sshd@3-172.31.22.251:22-147.75.109.163:48546.service: Deactivated successfully. Nov 12 22:22:44.366590 systemd[1]: session-4.scope: Deactivated successfully. Nov 12 22:22:44.367805 systemd-logind[1829]: Session 4 logged out. Waiting for processes to exit. Nov 12 22:22:44.369602 systemd-logind[1829]: Removed session 4. Nov 12 22:22:44.390175 systemd[1]: Started sshd@4-172.31.22.251:22-147.75.109.163:48552.service - OpenSSH per-connection server daemon (147.75.109.163:48552). Nov 12 22:22:44.592043 sshd[2100]: Accepted publickey for core from 147.75.109.163 port 48552 ssh2: RSA SHA256:uIlZGZS4ktpZyIP4/chqTIlyFelgeTnlXR9XFJx/YBs Nov 12 22:22:44.594626 sshd-session[2100]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:22:44.601869 systemd-logind[1829]: New session 5 of user core. Nov 12 22:22:44.611367 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 12 22:22:44.734974 sudo[2103]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Nov 12 22:22:44.735903 sudo[2103]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:22:44.755274 sudo[2103]: pam_unix(sudo:session): session closed for user root Nov 12 22:22:44.779894 sshd[2102]: Connection closed by 147.75.109.163 port 48552 Nov 12 22:22:44.781006 sshd-session[2100]: pam_unix(sshd:session): session closed for user core Nov 12 22:22:44.788467 systemd[1]: sshd@4-172.31.22.251:22-147.75.109.163:48552.service: Deactivated successfully. Nov 12 22:22:44.792441 systemd[1]: session-5.scope: Deactivated successfully. Nov 12 22:22:44.794278 systemd-logind[1829]: Session 5 logged out. Waiting for processes to exit. Nov 12 22:22:44.796909 systemd-logind[1829]: Removed session 5. Nov 12 22:22:44.817375 systemd[1]: Started sshd@5-172.31.22.251:22-147.75.109.163:48562.service - OpenSSH per-connection server daemon (147.75.109.163:48562). Nov 12 22:22:45.012930 sshd[2108]: Accepted publickey for core from 147.75.109.163 port 48562 ssh2: RSA SHA256:uIlZGZS4ktpZyIP4/chqTIlyFelgeTnlXR9XFJx/YBs Nov 12 22:22:45.015916 sshd-session[2108]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:22:45.022940 systemd-logind[1829]: New session 6 of user core. Nov 12 22:22:45.034054 systemd[1]: Started session-6.scope - Session 6 of User core. Nov 12 22:22:45.140305 sudo[2113]: 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 Nov 12 22:22:45.141647 sudo[2113]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:22:45.148805 sudo[2113]: pam_unix(sudo:session): session closed for user root Nov 12 22:22:45.159980 sudo[2112]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Nov 12 22:22:45.160650 sudo[2112]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:22:45.184416 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 12 22:22:45.233745 augenrules[2135]: No rules Nov 12 22:22:45.234903 systemd[1]: audit-rules.service: Deactivated successfully. Nov 12 22:22:45.235259 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 12 22:22:45.238192 sudo[2112]: pam_unix(sudo:session): session closed for user root Nov 12 22:22:45.263593 sshd[2111]: Connection closed by 147.75.109.163 port 48562 Nov 12 22:22:45.262759 sshd-session[2108]: pam_unix(sshd:session): session closed for user core Nov 12 22:22:45.270363 systemd[1]: sshd@5-172.31.22.251:22-147.75.109.163:48562.service: Deactivated successfully. Nov 12 22:22:45.273335 systemd[1]: session-6.scope: Deactivated successfully. Nov 12 22:22:45.274936 systemd-logind[1829]: Session 6 logged out. Waiting for processes to exit. Nov 12 22:22:45.277748 systemd-logind[1829]: Removed session 6. Nov 12 22:22:45.304546 systemd[1]: Started sshd@6-172.31.22.251:22-147.75.109.163:48574.service - OpenSSH per-connection server daemon (147.75.109.163:48574). Nov 12 22:22:45.490735 sshd[2143]: Accepted publickey for core from 147.75.109.163 port 48574 ssh2: RSA SHA256:uIlZGZS4ktpZyIP4/chqTIlyFelgeTnlXR9XFJx/YBs Nov 12 22:22:45.494124 sshd-session[2143]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:22:45.503978 systemd-logind[1829]: New session 7 of user core. Nov 12 22:22:45.517154 systemd[1]: Started session-7.scope - Session 7 of User core. Nov 12 22:22:45.624079 sudo[2148]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/tee /etc/flatcar/update.conf Nov 12 22:22:45.624747 sudo[2148]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:22:45.633013 sudo[2148]: pam_unix(sudo:session): session closed for user root Nov 12 22:22:45.640275 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 12 22:22:45.658043 sshd[2145]: Connection closed by 147.75.109.163 port 48574 Nov 12 22:22:45.660076 sshd-session[2143]: pam_unix(sshd:session): session closed for user core Nov 12 22:22:45.668654 systemd[1]: sshd@6-172.31.22.251:22-147.75.109.163:48574.service: Deactivated successfully. Nov 12 22:22:45.676410 systemd[1]: session-7.scope: Deactivated successfully. Nov 12 22:22:45.679078 systemd-logind[1829]: Session 7 logged out. Waiting for processes to exit. Nov 12 22:22:45.681461 systemd-logind[1829]: Removed session 7. Nov 12 22:22:45.685307 systemd[1]: motdgen.service: Deactivated successfully. Nov 12 22:22:45.685696 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 12 22:22:48.336798 systemd-resolved[1636]: Clock change detected. Flushing caches.