Dec 13 14:12:55.949724 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Dec 13 14:12:55.949761 kernel: Linux version 5.15.173-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 11.3.1_p20221209 p3) 11.3.1 20221209, GNU ld (Gentoo 2.39 p5) 2.39.0) #1 SMP PREEMPT Fri Dec 13 12:58:58 -00 2024 Dec 13 14:12:55.949785 kernel: efi: EFI v2.70 by EDK II Dec 13 14:12:55.949800 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b003a98 MEMRESERVE=0x7171cf98 Dec 13 14:12:55.949813 kernel: ACPI: Early table checksum verification disabled Dec 13 14:12:55.949827 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Dec 13 14:12:55.949843 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Dec 13 14:12:55.949857 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Dec 13 14:12:55.949871 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Dec 13 14:12:55.949884 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Dec 13 14:12:55.949902 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Dec 13 14:12:55.949916 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Dec 13 14:12:55.949930 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Dec 13 14:12:55.949944 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Dec 13 14:12:55.949960 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Dec 13 14:12:55.949979 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Dec 13 14:12:55.949994 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Dec 13 14:12:55.950009 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Dec 13 14:12:55.950023 kernel: printk: bootconsole [uart0] enabled Dec 13 14:12:55.950037 kernel: NUMA: Failed to initialise from firmware Dec 13 14:12:55.950052 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Dec 13 14:12:55.950067 kernel: NUMA: NODE_DATA [mem 0x4b5843900-0x4b5848fff] Dec 13 14:12:55.950081 kernel: Zone ranges: Dec 13 14:12:55.950096 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Dec 13 14:12:55.950110 kernel: DMA32 empty Dec 13 14:12:55.950124 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Dec 13 14:12:55.950143 kernel: Movable zone start for each node Dec 13 14:12:55.950158 kernel: Early memory node ranges Dec 13 14:12:55.950172 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Dec 13 14:12:55.950186 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Dec 13 14:12:55.950201 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Dec 13 14:12:55.950215 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Dec 13 14:12:55.950229 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Dec 13 14:12:55.950244 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Dec 13 14:12:55.950258 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Dec 13 14:12:55.950273 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Dec 13 14:12:55.950287 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Dec 13 14:12:55.950301 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Dec 13 14:12:55.950338 kernel: psci: probing for conduit method from ACPI. Dec 13 14:12:55.950356 kernel: psci: PSCIv1.0 detected in firmware. Dec 13 14:12:55.950379 kernel: psci: Using standard PSCI v0.2 function IDs Dec 13 14:12:55.950395 kernel: psci: Trusted OS migration not required Dec 13 14:12:55.950410 kernel: psci: SMC Calling Convention v1.1 Dec 13 14:12:55.950430 kernel: ACPI: SRAT not present Dec 13 14:12:55.950446 kernel: percpu: Embedded 30 pages/cpu s83032 r8192 d31656 u122880 Dec 13 14:12:55.950461 kernel: pcpu-alloc: s83032 r8192 d31656 u122880 alloc=30*4096 Dec 13 14:12:55.950477 kernel: pcpu-alloc: [0] 0 [0] 1 Dec 13 14:12:55.950492 kernel: Detected PIPT I-cache on CPU0 Dec 13 14:12:55.950507 kernel: CPU features: detected: GIC system register CPU interface Dec 13 14:12:55.950522 kernel: CPU features: detected: Spectre-v2 Dec 13 14:12:55.950537 kernel: CPU features: detected: Spectre-v3a Dec 13 14:12:55.950552 kernel: CPU features: detected: Spectre-BHB Dec 13 14:12:55.950567 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 13 14:12:55.950583 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 13 14:12:55.950602 kernel: CPU features: detected: ARM erratum 1742098 Dec 13 14:12:55.950618 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Dec 13 14:12:55.950633 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Dec 13 14:12:55.950649 kernel: Policy zone: Normal Dec 13 14:12:55.950667 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=5997a8cf94b1df1856dc785f0a7074604bbf4c21fdcca24a1996021471a77601 Dec 13 14:12:55.950683 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Dec 13 14:12:55.950699 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 13 14:12:55.950714 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 13 14:12:55.950729 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 13 14:12:55.950744 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Dec 13 14:12:55.950764 kernel: Memory: 3824524K/4030464K available (9792K kernel code, 2092K rwdata, 7576K rodata, 36416K init, 777K bss, 205940K reserved, 0K cma-reserved) Dec 13 14:12:55.950780 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Dec 13 14:12:55.950795 kernel: trace event string verifier disabled Dec 13 14:12:55.950810 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 13 14:12:55.950826 kernel: rcu: RCU event tracing is enabled. Dec 13 14:12:55.950842 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Dec 13 14:12:55.950858 kernel: Trampoline variant of Tasks RCU enabled. Dec 13 14:12:55.950873 kernel: Tracing variant of Tasks RCU enabled. Dec 13 14:12:55.950889 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 13 14:12:55.950904 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Dec 13 14:12:55.950919 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 13 14:12:55.950934 kernel: GICv3: 96 SPIs implemented Dec 13 14:12:55.950953 kernel: GICv3: 0 Extended SPIs implemented Dec 13 14:12:55.950968 kernel: GICv3: Distributor has no Range Selector support Dec 13 14:12:55.950983 kernel: Root IRQ handler: gic_handle_irq Dec 13 14:12:55.950998 kernel: GICv3: 16 PPIs implemented Dec 13 14:12:55.951013 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Dec 13 14:12:55.951028 kernel: ACPI: SRAT not present Dec 13 14:12:55.951043 kernel: ITS [mem 0x10080000-0x1009ffff] Dec 13 14:12:55.951058 kernel: ITS@0x0000000010080000: allocated 8192 Devices @400090000 (indirect, esz 8, psz 64K, shr 1) Dec 13 14:12:55.951088 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000a0000 (flat, esz 8, psz 64K, shr 1) Dec 13 14:12:55.951109 kernel: GICv3: using LPI property table @0x00000004000b0000 Dec 13 14:12:55.951125 kernel: ITS: Using hypervisor restricted LPI range [128] Dec 13 14:12:55.951146 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000d0000 Dec 13 14:12:55.951162 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Dec 13 14:12:55.951177 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Dec 13 14:12:55.951193 kernel: sched_clock: 56 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Dec 13 14:12:55.951209 kernel: Console: colour dummy device 80x25 Dec 13 14:12:55.951225 kernel: printk: console [tty1] enabled Dec 13 14:12:55.951242 kernel: ACPI: Core revision 20210730 Dec 13 14:12:55.951257 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Dec 13 14:12:55.951274 kernel: pid_max: default: 32768 minimum: 301 Dec 13 14:12:55.951289 kernel: LSM: Security Framework initializing Dec 13 14:12:55.951309 kernel: SELinux: Initializing. Dec 13 14:12:55.951344 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 13 14:12:55.951361 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 13 14:12:55.951377 kernel: rcu: Hierarchical SRCU implementation. Dec 13 14:12:55.951393 kernel: Platform MSI: ITS@0x10080000 domain created Dec 13 14:12:55.951409 kernel: PCI/MSI: ITS@0x10080000 domain created Dec 13 14:12:55.951425 kernel: Remapping and enabling EFI services. Dec 13 14:12:55.951441 kernel: smp: Bringing up secondary CPUs ... Dec 13 14:12:55.951456 kernel: Detected PIPT I-cache on CPU1 Dec 13 14:12:55.951473 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Dec 13 14:12:55.951495 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000e0000 Dec 13 14:12:55.951511 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Dec 13 14:12:55.951527 kernel: smp: Brought up 1 node, 2 CPUs Dec 13 14:12:55.951542 kernel: SMP: Total of 2 processors activated. Dec 13 14:12:55.951558 kernel: CPU features: detected: 32-bit EL0 Support Dec 13 14:12:55.951573 kernel: CPU features: detected: 32-bit EL1 Support Dec 13 14:12:55.951589 kernel: CPU features: detected: CRC32 instructions Dec 13 14:12:55.951604 kernel: CPU: All CPU(s) started at EL1 Dec 13 14:12:55.951621 kernel: alternatives: patching kernel code Dec 13 14:12:55.951643 kernel: devtmpfs: initialized Dec 13 14:12:55.951659 kernel: KASLR disabled due to lack of seed Dec 13 14:12:55.951688 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 13 14:12:55.951710 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Dec 13 14:12:55.951726 kernel: pinctrl core: initialized pinctrl subsystem Dec 13 14:12:55.951742 kernel: SMBIOS 3.0.0 present. Dec 13 14:12:55.951759 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Dec 13 14:12:55.951776 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 13 14:12:55.951792 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 13 14:12:55.951809 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 13 14:12:55.951826 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 13 14:12:55.951846 kernel: audit: initializing netlink subsys (disabled) Dec 13 14:12:55.951863 kernel: audit: type=2000 audit(0.249:1): state=initialized audit_enabled=0 res=1 Dec 13 14:12:55.951881 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 13 14:12:55.951898 kernel: cpuidle: using governor menu Dec 13 14:12:55.951914 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 13 14:12:55.951935 kernel: ASID allocator initialised with 32768 entries Dec 13 14:12:55.951952 kernel: ACPI: bus type PCI registered Dec 13 14:12:55.951968 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 13 14:12:55.951984 kernel: Serial: AMBA PL011 UART driver Dec 13 14:12:55.952000 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Dec 13 14:12:55.952017 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Dec 13 14:12:55.952033 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Dec 13 14:12:55.952049 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Dec 13 14:12:55.952065 kernel: cryptd: max_cpu_qlen set to 1000 Dec 13 14:12:55.952085 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Dec 13 14:12:55.952101 kernel: ACPI: Added _OSI(Module Device) Dec 13 14:12:55.952118 kernel: ACPI: Added _OSI(Processor Device) Dec 13 14:12:55.952134 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Dec 13 14:12:55.952150 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 13 14:12:55.952166 kernel: ACPI: Added _OSI(Linux-Dell-Video) Dec 13 14:12:55.952183 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Dec 13 14:12:55.952199 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Dec 13 14:12:55.952215 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 13 14:12:55.952236 kernel: ACPI: Interpreter enabled Dec 13 14:12:55.952252 kernel: ACPI: Using GIC for interrupt routing Dec 13 14:12:55.952268 kernel: ACPI: MCFG table detected, 1 entries Dec 13 14:12:55.952284 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Dec 13 14:12:55.952568 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 13 14:12:55.952759 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 13 14:12:55.952943 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 13 14:12:55.953127 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Dec 13 14:12:55.953393 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Dec 13 14:12:55.953428 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Dec 13 14:12:55.953445 kernel: acpiphp: Slot [1] registered Dec 13 14:12:55.953462 kernel: acpiphp: Slot [2] registered Dec 13 14:12:55.953479 kernel: acpiphp: Slot [3] registered Dec 13 14:12:55.953496 kernel: acpiphp: Slot [4] registered Dec 13 14:12:55.953512 kernel: acpiphp: Slot [5] registered Dec 13 14:12:55.953529 kernel: acpiphp: Slot [6] registered Dec 13 14:12:55.953545 kernel: acpiphp: Slot [7] registered Dec 13 14:12:55.953575 kernel: acpiphp: Slot [8] registered Dec 13 14:12:55.953592 kernel: acpiphp: Slot [9] registered Dec 13 14:12:55.953608 kernel: acpiphp: Slot [10] registered Dec 13 14:12:55.953625 kernel: acpiphp: Slot [11] registered Dec 13 14:12:55.953641 kernel: acpiphp: Slot [12] registered Dec 13 14:12:55.953658 kernel: acpiphp: Slot [13] registered Dec 13 14:12:55.953674 kernel: acpiphp: Slot [14] registered Dec 13 14:12:55.953692 kernel: acpiphp: Slot [15] registered Dec 13 14:12:55.953709 kernel: acpiphp: Slot [16] registered Dec 13 14:12:55.953730 kernel: acpiphp: Slot [17] registered Dec 13 14:12:55.953746 kernel: acpiphp: Slot [18] registered Dec 13 14:12:55.953764 kernel: acpiphp: Slot [19] registered Dec 13 14:12:55.953780 kernel: acpiphp: Slot [20] registered Dec 13 14:12:55.953796 kernel: acpiphp: Slot [21] registered Dec 13 14:12:55.953814 kernel: acpiphp: Slot [22] registered Dec 13 14:12:55.953831 kernel: acpiphp: Slot [23] registered Dec 13 14:12:55.953847 kernel: acpiphp: Slot [24] registered Dec 13 14:12:55.953864 kernel: acpiphp: Slot [25] registered Dec 13 14:12:55.953881 kernel: acpiphp: Slot [26] registered Dec 13 14:12:55.953904 kernel: acpiphp: Slot [27] registered Dec 13 14:12:55.953921 kernel: acpiphp: Slot [28] registered Dec 13 14:12:55.953936 kernel: acpiphp: Slot [29] registered Dec 13 14:12:55.953953 kernel: acpiphp: Slot [30] registered Dec 13 14:12:55.953969 kernel: acpiphp: Slot [31] registered Dec 13 14:12:55.953985 kernel: PCI host bridge to bus 0000:00 Dec 13 14:12:55.954250 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Dec 13 14:12:55.956592 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 13 14:12:55.956875 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Dec 13 14:12:55.972478 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Dec 13 14:12:55.972718 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Dec 13 14:12:55.972939 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Dec 13 14:12:55.973132 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Dec 13 14:12:55.978387 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Dec 13 14:12:55.978650 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Dec 13 14:12:55.978845 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Dec 13 14:12:55.979049 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Dec 13 14:12:55.979283 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Dec 13 14:12:55.979523 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Dec 13 14:12:55.979712 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Dec 13 14:12:55.979901 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Dec 13 14:12:55.980095 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Dec 13 14:12:55.980283 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Dec 13 14:12:55.980511 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Dec 13 14:12:55.980706 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Dec 13 14:12:55.980906 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Dec 13 14:12:55.981085 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Dec 13 14:12:55.981259 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 13 14:12:55.981466 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Dec 13 14:12:55.981491 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Dec 13 14:12:55.981508 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Dec 13 14:12:55.981525 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Dec 13 14:12:55.981542 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Dec 13 14:12:55.981558 kernel: iommu: Default domain type: Translated Dec 13 14:12:55.981575 kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 13 14:12:55.981591 kernel: vgaarb: loaded Dec 13 14:12:55.981607 kernel: pps_core: LinuxPPS API ver. 1 registered Dec 13 14:12:55.981630 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Dec 13 14:12:55.981646 kernel: PTP clock support registered Dec 13 14:12:55.981662 kernel: Registered efivars operations Dec 13 14:12:55.981678 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 13 14:12:55.981694 kernel: VFS: Disk quotas dquot_6.6.0 Dec 13 14:12:55.981711 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 13 14:12:55.981727 kernel: pnp: PnP ACPI init Dec 13 14:12:55.981924 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Dec 13 14:12:55.981953 kernel: pnp: PnP ACPI: found 1 devices Dec 13 14:12:55.981970 kernel: NET: Registered PF_INET protocol family Dec 13 14:12:55.981986 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 13 14:12:55.982003 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 13 14:12:55.982019 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 13 14:12:55.982036 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 13 14:12:55.982053 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Dec 13 14:12:55.982069 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 13 14:12:55.982085 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 13 14:12:55.982106 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 13 14:12:55.982122 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 13 14:12:55.982138 kernel: PCI: CLS 0 bytes, default 64 Dec 13 14:12:55.982155 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Dec 13 14:12:55.982171 kernel: kvm [1]: HYP mode not available Dec 13 14:12:55.982187 kernel: Initialise system trusted keyrings Dec 13 14:12:55.982204 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 13 14:12:55.982221 kernel: Key type asymmetric registered Dec 13 14:12:55.982237 kernel: Asymmetric key parser 'x509' registered Dec 13 14:12:55.982258 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Dec 13 14:12:55.982274 kernel: io scheduler mq-deadline registered Dec 13 14:12:55.982291 kernel: io scheduler kyber registered Dec 13 14:12:55.982307 kernel: io scheduler bfq registered Dec 13 14:12:55.982558 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Dec 13 14:12:55.982585 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 13 14:12:55.982602 kernel: ACPI: button: Power Button [PWRB] Dec 13 14:12:55.982618 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Dec 13 14:12:55.982640 kernel: ACPI: button: Sleep Button [SLPB] Dec 13 14:12:55.982657 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 13 14:12:55.982674 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Dec 13 14:12:55.982868 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Dec 13 14:12:55.982891 kernel: printk: console [ttyS0] disabled Dec 13 14:12:55.982908 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Dec 13 14:12:55.982925 kernel: printk: console [ttyS0] enabled Dec 13 14:12:55.982941 kernel: printk: bootconsole [uart0] disabled Dec 13 14:12:55.982957 kernel: thunder_xcv, ver 1.0 Dec 13 14:12:55.982973 kernel: thunder_bgx, ver 1.0 Dec 13 14:12:55.982994 kernel: nicpf, ver 1.0 Dec 13 14:12:55.983010 kernel: nicvf, ver 1.0 Dec 13 14:12:55.983245 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 13 14:12:55.995881 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-12-13T14:12:55 UTC (1734099175) Dec 13 14:12:55.995928 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 13 14:12:55.995948 kernel: NET: Registered PF_INET6 protocol family Dec 13 14:12:55.995965 kernel: Segment Routing with IPv6 Dec 13 14:12:55.995982 kernel: In-situ OAM (IOAM) with IPv6 Dec 13 14:12:55.996008 kernel: NET: Registered PF_PACKET protocol family Dec 13 14:12:55.996024 kernel: Key type dns_resolver registered Dec 13 14:12:55.996041 kernel: registered taskstats version 1 Dec 13 14:12:55.996057 kernel: Loading compiled-in X.509 certificates Dec 13 14:12:55.996074 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.173-flatcar: e011ba9949ade5a6d03f7a5e28171f7f59e70f8a' Dec 13 14:12:55.996091 kernel: Key type .fscrypt registered Dec 13 14:12:55.996107 kernel: Key type fscrypt-provisioning registered Dec 13 14:12:55.996123 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 13 14:12:55.996140 kernel: ima: Allocated hash algorithm: sha1 Dec 13 14:12:55.996160 kernel: ima: No architecture policies found Dec 13 14:12:55.996177 kernel: clk: Disabling unused clocks Dec 13 14:12:55.996194 kernel: Freeing unused kernel memory: 36416K Dec 13 14:12:55.996210 kernel: Run /init as init process Dec 13 14:12:55.996226 kernel: with arguments: Dec 13 14:12:55.996242 kernel: /init Dec 13 14:12:55.996258 kernel: with environment: Dec 13 14:12:55.996274 kernel: HOME=/ Dec 13 14:12:55.996290 kernel: TERM=linux Dec 13 14:12:55.996336 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Dec 13 14:12:55.996364 systemd[1]: systemd 252 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) Dec 13 14:12:55.996387 systemd[1]: Detected virtualization amazon. Dec 13 14:12:55.996406 systemd[1]: Detected architecture arm64. Dec 13 14:12:55.996423 systemd[1]: Running in initrd. Dec 13 14:12:55.996441 systemd[1]: No hostname configured, using default hostname. Dec 13 14:12:55.996459 systemd[1]: Hostname set to . Dec 13 14:12:55.996482 systemd[1]: Initializing machine ID from VM UUID. Dec 13 14:12:55.996500 systemd[1]: Queued start job for default target initrd.target. Dec 13 14:12:55.996518 systemd[1]: Started systemd-ask-password-console.path. Dec 13 14:12:55.996536 systemd[1]: Reached target cryptsetup.target. Dec 13 14:12:55.996554 systemd[1]: Reached target paths.target. Dec 13 14:12:55.996571 systemd[1]: Reached target slices.target. Dec 13 14:12:55.996588 systemd[1]: Reached target swap.target. Dec 13 14:12:55.996606 systemd[1]: Reached target timers.target. Dec 13 14:12:55.996629 systemd[1]: Listening on iscsid.socket. Dec 13 14:12:55.996647 systemd[1]: Listening on iscsiuio.socket. Dec 13 14:12:55.996665 systemd[1]: Listening on systemd-journald-audit.socket. Dec 13 14:12:55.996682 systemd[1]: Listening on systemd-journald-dev-log.socket. Dec 13 14:12:55.996700 systemd[1]: Listening on systemd-journald.socket. Dec 13 14:12:55.996718 systemd[1]: Listening on systemd-networkd.socket. Dec 13 14:12:55.996736 systemd[1]: Listening on systemd-udevd-control.socket. Dec 13 14:12:55.996754 systemd[1]: Listening on systemd-udevd-kernel.socket. Dec 13 14:12:55.996776 systemd[1]: Reached target sockets.target. Dec 13 14:12:55.996795 systemd[1]: Starting kmod-static-nodes.service... Dec 13 14:12:55.996813 systemd[1]: Finished network-cleanup.service. Dec 13 14:12:55.996831 systemd[1]: Starting systemd-fsck-usr.service... Dec 13 14:12:55.996849 systemd[1]: Starting systemd-journald.service... Dec 13 14:12:55.996867 systemd[1]: Starting systemd-modules-load.service... Dec 13 14:12:55.996885 systemd[1]: Starting systemd-resolved.service... Dec 13 14:12:55.996903 systemd[1]: Starting systemd-vconsole-setup.service... Dec 13 14:12:55.996921 systemd[1]: Finished kmod-static-nodes.service. Dec 13 14:12:55.996944 kernel: audit: type=1130 audit(1734099175.945:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:55.996963 systemd[1]: Finished systemd-fsck-usr.service. Dec 13 14:12:55.996981 kernel: audit: type=1130 audit(1734099175.960:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:55.996999 systemd[1]: Finished systemd-vconsole-setup.service. Dec 13 14:12:55.997017 kernel: audit: type=1130 audit(1734099175.984:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:55.997035 systemd[1]: Starting dracut-cmdline-ask.service... Dec 13 14:12:55.997057 systemd-journald[309]: Journal started Dec 13 14:12:55.997152 systemd-journald[309]: Runtime Journal (/run/log/journal/ec282c2491b11c5a559aaa6439e17a64) is 8.0M, max 75.4M, 67.4M free. Dec 13 14:12:55.997219 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Dec 13 14:12:55.945000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:55.960000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:55.984000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:55.945212 systemd-modules-load[310]: Inserted module 'overlay' Dec 13 14:12:56.013120 systemd[1]: Started systemd-journald.service. Dec 13 14:12:56.013187 kernel: audit: type=1130 audit(1734099176.005:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.005000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.038255 systemd-resolved[311]: Positive Trust Anchors: Dec 13 14:12:56.038272 systemd-resolved[311]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 13 14:12:56.038343 systemd-resolved[311]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Dec 13 14:12:56.045998 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Dec 13 14:12:56.045609 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Dec 13 14:12:56.044000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.062345 kernel: Bridge firewalling registered Dec 13 14:12:56.062383 kernel: audit: type=1130 audit(1734099176.044:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.062558 systemd-modules-load[310]: Inserted module 'br_netfilter' Dec 13 14:12:56.086780 systemd[1]: Finished dracut-cmdline-ask.service. Dec 13 14:12:56.087000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.089995 systemd[1]: Starting dracut-cmdline.service... Dec 13 14:12:56.100363 kernel: audit: type=1130 audit(1734099176.087:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.113348 kernel: SCSI subsystem initialized Dec 13 14:12:56.122389 dracut-cmdline[328]: dracut-dracut-053 Dec 13 14:12:56.133675 dracut-cmdline[328]: 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=5997a8cf94b1df1856dc785f0a7074604bbf4c21fdcca24a1996021471a77601 Dec 13 14:12:56.155226 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Dec 13 14:12:56.155265 kernel: device-mapper: uevent: version 1.0.3 Dec 13 14:12:56.155288 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Dec 13 14:12:56.156766 systemd-modules-load[310]: Inserted module 'dm_multipath' Dec 13 14:12:56.158716 systemd[1]: Finished systemd-modules-load.service. Dec 13 14:12:56.162477 systemd[1]: Starting systemd-sysctl.service... Dec 13 14:12:56.159000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.175343 kernel: audit: type=1130 audit(1734099176.159:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.190331 systemd[1]: Finished systemd-sysctl.service. Dec 13 14:12:56.199858 kernel: audit: type=1130 audit(1734099176.190:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.190000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.297344 kernel: Loading iSCSI transport class v2.0-870. Dec 13 14:12:56.315351 kernel: iscsi: registered transport (tcp) Dec 13 14:12:56.341596 kernel: iscsi: registered transport (qla4xxx) Dec 13 14:12:56.341667 kernel: QLogic iSCSI HBA Driver Dec 13 14:12:56.551858 systemd-resolved[311]: Defaulting to hostname 'linux'. Dec 13 14:12:56.554301 kernel: random: crng init done Dec 13 14:12:56.554995 systemd[1]: Started systemd-resolved.service. Dec 13 14:12:56.558564 systemd[1]: Reached target nss-lookup.target. Dec 13 14:12:56.557000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.575680 kernel: audit: type=1130 audit(1734099176.557:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.577280 systemd[1]: Finished dracut-cmdline.service. Dec 13 14:12:56.580000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:56.583802 systemd[1]: Starting dracut-pre-udev.service... Dec 13 14:12:56.648353 kernel: raid6: neonx8 gen() 6413 MB/s Dec 13 14:12:56.666337 kernel: raid6: neonx8 xor() 4757 MB/s Dec 13 14:12:56.684342 kernel: raid6: neonx4 gen() 6536 MB/s Dec 13 14:12:56.702337 kernel: raid6: neonx4 xor() 4938 MB/s Dec 13 14:12:56.720345 kernel: raid6: neonx2 gen() 5797 MB/s Dec 13 14:12:56.738340 kernel: raid6: neonx2 xor() 4532 MB/s Dec 13 14:12:56.756345 kernel: raid6: neonx1 gen() 4470 MB/s Dec 13 14:12:56.774345 kernel: raid6: neonx1 xor() 3692 MB/s Dec 13 14:12:56.792346 kernel: raid6: int64x8 gen() 3421 MB/s Dec 13 14:12:56.810345 kernel: raid6: int64x8 xor() 2089 MB/s Dec 13 14:12:56.828346 kernel: raid6: int64x4 gen() 3798 MB/s Dec 13 14:12:56.846345 kernel: raid6: int64x4 xor() 2192 MB/s Dec 13 14:12:56.864345 kernel: raid6: int64x2 gen() 3610 MB/s Dec 13 14:12:56.882347 kernel: raid6: int64x2 xor() 1948 MB/s Dec 13 14:12:56.900346 kernel: raid6: int64x1 gen() 2771 MB/s Dec 13 14:12:56.919478 kernel: raid6: int64x1 xor() 1450 MB/s Dec 13 14:12:56.919510 kernel: raid6: using algorithm neonx4 gen() 6536 MB/s Dec 13 14:12:56.919534 kernel: raid6: .... xor() 4938 MB/s, rmw enabled Dec 13 14:12:56.921087 kernel: raid6: using neon recovery algorithm Dec 13 14:12:56.940649 kernel: xor: measuring software checksum speed Dec 13 14:12:56.940710 kernel: 8regs : 9059 MB/sec Dec 13 14:12:56.942399 kernel: 32regs : 11092 MB/sec Dec 13 14:12:56.944172 kernel: arm64_neon : 9586 MB/sec Dec 13 14:12:56.944201 kernel: xor: using function: 32regs (11092 MB/sec) Dec 13 14:12:57.036366 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Dec 13 14:12:57.055448 systemd[1]: Finished dracut-pre-udev.service. Dec 13 14:12:57.055000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:57.057000 audit: BPF prog-id=7 op=LOAD Dec 13 14:12:57.057000 audit: BPF prog-id=8 op=LOAD Dec 13 14:12:57.059483 systemd[1]: Starting systemd-udevd.service... Dec 13 14:12:57.087509 systemd-udevd[509]: Using default interface naming scheme 'v252'. Dec 13 14:12:57.098195 systemd[1]: Started systemd-udevd.service. Dec 13 14:12:57.098000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:57.104229 systemd[1]: Starting dracut-pre-trigger.service... Dec 13 14:12:57.134788 dracut-pre-trigger[519]: rd.md=0: removing MD RAID activation Dec 13 14:12:57.194579 systemd[1]: Finished dracut-pre-trigger.service. Dec 13 14:12:57.195000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:57.198948 systemd[1]: Starting systemd-udev-trigger.service... Dec 13 14:12:57.298138 systemd[1]: Finished systemd-udev-trigger.service. Dec 13 14:12:57.298000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:57.429907 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Dec 13 14:12:57.429979 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Dec 13 14:12:57.430005 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Dec 13 14:12:57.449585 kernel: nvme nvme0: pci function 0000:00:04.0 Dec 13 14:12:57.449842 kernel: ena 0000:00:05.0: ENA device version: 0.10 Dec 13 14:12:57.450044 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Dec 13 14:12:57.450237 kernel: nvme nvme0: 2/0/0 default/read/poll queues Dec 13 14:12:57.450463 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:ed:5e:e5:51:dd Dec 13 14:12:57.454376 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Dec 13 14:12:57.454421 kernel: GPT:9289727 != 16777215 Dec 13 14:12:57.454445 kernel: GPT:Alternate GPT header not at the end of the disk. Dec 13 14:12:57.456305 kernel: GPT:9289727 != 16777215 Dec 13 14:12:57.457504 kernel: GPT: Use GNU Parted to correct GPT errors. Dec 13 14:12:57.460541 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Dec 13 14:12:57.465005 (udev-worker)[565]: Network interface NamePolicy= disabled on kernel command line. Dec 13 14:12:57.528356 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by (udev-worker) (562) Dec 13 14:12:57.578647 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Dec 13 14:12:57.582705 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Dec 13 14:12:57.591757 systemd[1]: Starting disk-uuid.service... Dec 13 14:12:57.603385 disk-uuid[643]: Primary Header is updated. Dec 13 14:12:57.603385 disk-uuid[643]: Secondary Entries is updated. Dec 13 14:12:57.603385 disk-uuid[643]: Secondary Header is updated. Dec 13 14:12:57.628238 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Dec 13 14:12:57.646667 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Dec 13 14:12:57.672082 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Dec 13 14:12:58.623165 disk-uuid[645]: The operation has completed successfully. Dec 13 14:12:58.625400 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Dec 13 14:12:58.797540 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 13 14:12:58.799000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:58.799000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:58.797749 systemd[1]: Finished disk-uuid.service. Dec 13 14:12:58.821725 systemd[1]: Starting verity-setup.service... Dec 13 14:12:58.858377 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Dec 13 14:12:58.955060 systemd[1]: Found device dev-mapper-usr.device. Dec 13 14:12:58.961857 systemd[1]: Mounting sysusr-usr.mount... Dec 13 14:12:58.969631 systemd[1]: Finished verity-setup.service. Dec 13 14:12:58.969000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:59.059338 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Dec 13 14:12:59.059673 systemd[1]: Mounted sysusr-usr.mount. Dec 13 14:12:59.062508 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Dec 13 14:12:59.065386 systemd[1]: Starting ignition-setup.service... Dec 13 14:12:59.070776 systemd[1]: Starting parse-ip-for-networkd.service... Dec 13 14:12:59.100116 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Dec 13 14:12:59.100181 kernel: BTRFS info (device nvme0n1p6): using free space tree Dec 13 14:12:59.100205 kernel: BTRFS info (device nvme0n1p6): has skinny extents Dec 13 14:12:59.112451 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Dec 13 14:12:59.131364 systemd[1]: mnt-oem.mount: Deactivated successfully. Dec 13 14:12:59.147932 systemd[1]: Finished ignition-setup.service. Dec 13 14:12:59.152291 systemd[1]: Starting ignition-fetch-offline.service... Dec 13 14:12:59.149000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:59.221262 systemd[1]: Finished parse-ip-for-networkd.service. Dec 13 14:12:59.223000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:59.224000 audit: BPF prog-id=9 op=LOAD Dec 13 14:12:59.226653 systemd[1]: Starting systemd-networkd.service... Dec 13 14:12:59.272011 systemd-networkd[1195]: lo: Link UP Dec 13 14:12:59.272034 systemd-networkd[1195]: lo: Gained carrier Dec 13 14:12:59.275114 systemd-networkd[1195]: Enumeration completed Dec 13 14:12:59.275598 systemd-networkd[1195]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 13 14:12:59.280679 systemd[1]: Started systemd-networkd.service. Dec 13 14:12:59.282477 systemd-networkd[1195]: eth0: Link UP Dec 13 14:12:59.282485 systemd-networkd[1195]: eth0: Gained carrier Dec 13 14:12:59.285000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:59.287535 systemd[1]: Reached target network.target. Dec 13 14:12:59.292459 systemd[1]: Starting iscsiuio.service... Dec 13 14:12:59.301520 systemd-networkd[1195]: eth0: DHCPv4 address 172.31.24.189/20, gateway 172.31.16.1 acquired from 172.31.16.1 Dec 13 14:12:59.305777 systemd[1]: Started iscsiuio.service. Dec 13 14:12:59.307000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:59.323573 systemd[1]: Starting iscsid.service... Dec 13 14:12:59.332056 iscsid[1200]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Dec 13 14:12:59.332056 iscsid[1200]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Dec 13 14:12:59.332056 iscsid[1200]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Dec 13 14:12:59.332056 iscsid[1200]: If using hardware iscsi like qla4xxx this message can be ignored. Dec 13 14:12:59.332056 iscsid[1200]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Dec 13 14:12:59.350045 iscsid[1200]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Dec 13 14:12:59.355371 systemd[1]: Started iscsid.service. Dec 13 14:12:59.355000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:59.358676 systemd[1]: Starting dracut-initqueue.service... Dec 13 14:12:59.382918 systemd[1]: Finished dracut-initqueue.service. Dec 13 14:12:59.383000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:59.384825 systemd[1]: Reached target remote-fs-pre.target. Dec 13 14:12:59.386445 systemd[1]: Reached target remote-cryptsetup.target. Dec 13 14:12:59.389534 systemd[1]: Reached target remote-fs.target. Dec 13 14:12:59.412000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:12:59.392561 systemd[1]: Starting dracut-pre-mount.service... Dec 13 14:12:59.410567 systemd[1]: Finished dracut-pre-mount.service. Dec 13 14:13:00.274149 ignition[1131]: Ignition 2.14.0 Dec 13 14:13:00.274182 ignition[1131]: Stage: fetch-offline Dec 13 14:13:00.274660 ignition[1131]: reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:13:00.275669 ignition[1131]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:13:00.293274 ignition[1131]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:13:00.295284 ignition[1131]: Ignition finished successfully Dec 13 14:13:00.298406 systemd[1]: Finished ignition-fetch-offline.service. Dec 13 14:13:00.310208 kernel: kauditd_printk_skb: 18 callbacks suppressed Dec 13 14:13:00.310241 kernel: audit: type=1130 audit(1734099180.298:29): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.298000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.311473 systemd[1]: Starting ignition-fetch.service... Dec 13 14:13:00.326536 ignition[1219]: Ignition 2.14.0 Dec 13 14:13:00.326562 ignition[1219]: Stage: fetch Dec 13 14:13:00.326853 ignition[1219]: reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:13:00.326911 ignition[1219]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:13:00.340058 ignition[1219]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:13:00.342248 ignition[1219]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:13:00.356043 ignition[1219]: INFO : PUT result: OK Dec 13 14:13:00.359112 ignition[1219]: DEBUG : parsed url from cmdline: "" Dec 13 14:13:00.359112 ignition[1219]: INFO : no config URL provided Dec 13 14:13:00.359112 ignition[1219]: INFO : reading system config file "/usr/lib/ignition/user.ign" Dec 13 14:13:00.359112 ignition[1219]: INFO : no config at "/usr/lib/ignition/user.ign" Dec 13 14:13:00.359112 ignition[1219]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:13:00.372294 ignition[1219]: INFO : PUT result: OK Dec 13 14:13:00.372294 ignition[1219]: INFO : GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Dec 13 14:13:00.372294 ignition[1219]: INFO : GET result: OK Dec 13 14:13:00.372294 ignition[1219]: DEBUG : parsing config with SHA512: fea5cf72f981896f8a2438cf5004ae5580bd1d610d88e38f6d6d5ea998aef9e028623e3ecf12a2aec6fe2927c11039abc0219744cf4acd3318dcef53beb2cc58 Dec 13 14:13:00.386208 unknown[1219]: fetched base config from "system" Dec 13 14:13:00.386236 unknown[1219]: fetched base config from "system" Dec 13 14:13:00.386251 unknown[1219]: fetched user config from "aws" Dec 13 14:13:00.391125 ignition[1219]: fetch: fetch complete Dec 13 14:13:00.391149 ignition[1219]: fetch: fetch passed Dec 13 14:13:00.392475 ignition[1219]: Ignition finished successfully Dec 13 14:13:00.407552 systemd[1]: Finished ignition-fetch.service. Dec 13 14:13:00.410000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.413683 systemd[1]: Starting ignition-kargs.service... Dec 13 14:13:00.421801 kernel: audit: type=1130 audit(1734099180.410:30): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.436335 ignition[1225]: Ignition 2.14.0 Dec 13 14:13:00.436364 ignition[1225]: Stage: kargs Dec 13 14:13:00.436673 ignition[1225]: reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:13:00.436733 ignition[1225]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:13:00.451302 ignition[1225]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:13:00.453452 ignition[1225]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:13:00.456486 ignition[1225]: INFO : PUT result: OK Dec 13 14:13:00.460803 ignition[1225]: kargs: kargs passed Dec 13 14:13:00.460891 ignition[1225]: Ignition finished successfully Dec 13 14:13:00.464134 systemd[1]: Finished ignition-kargs.service. Dec 13 14:13:00.467000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.477646 systemd[1]: Starting ignition-disks.service... Dec 13 14:13:00.481611 kernel: audit: type=1130 audit(1734099180.467:31): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.493035 ignition[1231]: Ignition 2.14.0 Dec 13 14:13:00.493063 ignition[1231]: Stage: disks Dec 13 14:13:00.493379 ignition[1231]: reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:13:00.493433 ignition[1231]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:13:00.505454 ignition[1231]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:13:00.507935 ignition[1231]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:13:00.510831 ignition[1231]: INFO : PUT result: OK Dec 13 14:13:00.514599 ignition[1231]: disks: disks passed Dec 13 14:13:00.514729 ignition[1231]: Ignition finished successfully Dec 13 14:13:00.518687 systemd[1]: Finished ignition-disks.service. Dec 13 14:13:00.521632 systemd[1]: Reached target initrd-root-device.target. Dec 13 14:13:00.531159 kernel: audit: type=1130 audit(1734099180.520:32): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.520000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.531150 systemd[1]: Reached target local-fs-pre.target. Dec 13 14:13:00.532750 systemd[1]: Reached target local-fs.target. Dec 13 14:13:00.535866 systemd[1]: Reached target sysinit.target. Dec 13 14:13:00.538439 systemd[1]: Reached target basic.target. Dec 13 14:13:00.543781 systemd[1]: Starting systemd-fsck-root.service... Dec 13 14:13:00.610244 systemd-fsck[1239]: ROOT: clean, 621/553520 files, 56020/553472 blocks Dec 13 14:13:00.617155 systemd[1]: Finished systemd-fsck-root.service. Dec 13 14:13:00.620557 systemd[1]: Mounting sysroot.mount... Dec 13 14:13:00.616000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.631358 kernel: audit: type=1130 audit(1734099180.616:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.652360 kernel: EXT4-fs (nvme0n1p9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Dec 13 14:13:00.654361 systemd[1]: Mounted sysroot.mount. Dec 13 14:13:00.655761 systemd[1]: Reached target initrd-root-fs.target. Dec 13 14:13:00.668042 systemd[1]: Mounting sysroot-usr.mount... Dec 13 14:13:00.672192 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Dec 13 14:13:00.672287 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Dec 13 14:13:00.672396 systemd[1]: Reached target ignition-diskful.target. Dec 13 14:13:00.689381 systemd[1]: Mounted sysroot-usr.mount. Dec 13 14:13:00.698726 systemd[1]: Mounting sysroot-usr-share-oem.mount... Dec 13 14:13:00.701653 systemd[1]: Starting initrd-setup-root.service... Dec 13 14:13:00.720895 initrd-setup-root[1261]: cut: /sysroot/etc/passwd: No such file or directory Dec 13 14:13:00.730742 initrd-setup-root[1269]: cut: /sysroot/etc/group: No such file or directory Dec 13 14:13:00.739359 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by mount (1256) Dec 13 14:13:00.741301 initrd-setup-root[1277]: cut: /sysroot/etc/shadow: No such file or directory Dec 13 14:13:00.749688 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Dec 13 14:13:00.749725 kernel: BTRFS info (device nvme0n1p6): using free space tree Dec 13 14:13:00.749749 kernel: BTRFS info (device nvme0n1p6): has skinny extents Dec 13 14:13:00.754550 initrd-setup-root[1300]: cut: /sysroot/etc/gshadow: No such file or directory Dec 13 14:13:00.792362 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Dec 13 14:13:00.802860 systemd[1]: Mounted sysroot-usr-share-oem.mount. Dec 13 14:13:00.971091 systemd[1]: Finished initrd-setup-root.service. Dec 13 14:13:00.972000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.977737 systemd[1]: Starting ignition-mount.service... Dec 13 14:13:00.985530 kernel: audit: type=1130 audit(1734099180.972:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:00.984583 systemd[1]: Starting sysroot-boot.service... Dec 13 14:13:00.997933 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. Dec 13 14:13:00.998274 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. Dec 13 14:13:01.019407 ignition[1321]: INFO : Ignition 2.14.0 Dec 13 14:13:01.021193 ignition[1321]: INFO : Stage: mount Dec 13 14:13:01.022623 ignition[1321]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:13:01.025528 ignition[1321]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:13:01.024901 systemd-networkd[1195]: eth0: Gained IPv6LL Dec 13 14:13:01.041072 ignition[1321]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:13:01.043822 ignition[1321]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:13:01.046880 ignition[1321]: INFO : PUT result: OK Dec 13 14:13:01.051294 ignition[1321]: INFO : mount: mount passed Dec 13 14:13:01.052818 ignition[1321]: INFO : Ignition finished successfully Dec 13 14:13:01.055184 systemd[1]: Finished ignition-mount.service. Dec 13 14:13:01.055000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.064510 systemd[1]: Starting ignition-files.service... Dec 13 14:13:01.069357 kernel: audit: type=1130 audit(1734099181.055:35): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.076575 systemd[1]: Finished sysroot-boot.service. Dec 13 14:13:01.078000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.086363 kernel: audit: type=1130 audit(1734099181.078:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.089480 systemd[1]: Mounting sysroot-usr-share-oem.mount... Dec 13 14:13:01.115356 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by mount (1331) Dec 13 14:13:01.121045 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Dec 13 14:13:01.121089 kernel: BTRFS info (device nvme0n1p6): using free space tree Dec 13 14:13:01.121113 kernel: BTRFS info (device nvme0n1p6): has skinny extents Dec 13 14:13:01.138361 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Dec 13 14:13:01.144023 systemd[1]: Mounted sysroot-usr-share-oem.mount. Dec 13 14:13:01.162150 ignition[1350]: INFO : Ignition 2.14.0 Dec 13 14:13:01.162150 ignition[1350]: INFO : Stage: files Dec 13 14:13:01.165792 ignition[1350]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:13:01.165792 ignition[1350]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:13:01.179827 ignition[1350]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:13:01.182143 ignition[1350]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:13:01.185026 ignition[1350]: INFO : PUT result: OK Dec 13 14:13:01.189580 ignition[1350]: DEBUG : files: compiled without relabeling support, skipping Dec 13 14:13:01.193684 ignition[1350]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Dec 13 14:13:01.196165 ignition[1350]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Dec 13 14:13:01.205450 ignition[1350]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Dec 13 14:13:01.208284 ignition[1350]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Dec 13 14:13:01.212043 unknown[1350]: wrote ssh authorized keys file for user: core Dec 13 14:13:01.214120 ignition[1350]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Dec 13 14:13:01.225454 ignition[1350]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/eks/bootstrap.sh" Dec 13 14:13:01.228749 ignition[1350]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Dec 13 14:13:01.240292 ignition[1350]: INFO : op(1): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3305739686" Dec 13 14:13:01.246642 kernel: BTRFS info: devid 1 device path /dev/nvme0n1p6 changed to /dev/disk/by-label/OEM scanned by ignition (1355) Dec 13 14:13:01.246678 ignition[1350]: CRITICAL : op(1): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3305739686": device or resource busy Dec 13 14:13:01.246678 ignition[1350]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3305739686", trying btrfs: device or resource busy Dec 13 14:13:01.246678 ignition[1350]: INFO : op(2): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3305739686" Dec 13 14:13:01.255196 ignition[1350]: INFO : op(2): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3305739686" Dec 13 14:13:01.291826 ignition[1350]: INFO : op(3): [started] unmounting "/mnt/oem3305739686" Dec 13 14:13:01.293943 ignition[1350]: INFO : op(3): [finished] unmounting "/mnt/oem3305739686" Dec 13 14:13:01.295926 ignition[1350]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/eks/bootstrap.sh" Dec 13 14:13:01.295926 ignition[1350]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Dec 13 14:13:01.295926 ignition[1350]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Dec 13 14:13:01.295926 ignition[1350]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Dec 13 14:13:01.308653 ignition[1350]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Dec 13 14:13:01.319512 ignition[1350]: INFO : op(4): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1414356456" Dec 13 14:13:01.319512 ignition[1350]: CRITICAL : op(4): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1414356456": device or resource busy Dec 13 14:13:01.319512 ignition[1350]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem1414356456", trying btrfs: device or resource busy Dec 13 14:13:01.319512 ignition[1350]: INFO : op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1414356456" Dec 13 14:13:01.331099 ignition[1350]: INFO : op(5): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1414356456" Dec 13 14:13:01.331099 ignition[1350]: INFO : op(6): [started] unmounting "/mnt/oem1414356456" Dec 13 14:13:01.331099 ignition[1350]: INFO : op(6): [finished] unmounting "/mnt/oem1414356456" Dec 13 14:13:01.331099 ignition[1350]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Dec 13 14:13:01.331099 ignition[1350]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Dec 13 14:13:01.331099 ignition[1350]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Dec 13 14:13:01.359629 ignition[1350]: INFO : op(7): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem286364906" Dec 13 14:13:01.362343 ignition[1350]: CRITICAL : op(7): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem286364906": device or resource busy Dec 13 14:13:01.362343 ignition[1350]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem286364906", trying btrfs: device or resource busy Dec 13 14:13:01.362343 ignition[1350]: INFO : op(8): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem286364906" Dec 13 14:13:01.371013 ignition[1350]: INFO : op(8): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem286364906" Dec 13 14:13:01.371013 ignition[1350]: INFO : op(9): [started] unmounting "/mnt/oem286364906" Dec 13 14:13:01.371013 ignition[1350]: INFO : op(9): [finished] unmounting "/mnt/oem286364906" Dec 13 14:13:01.371013 ignition[1350]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Dec 13 14:13:01.371013 ignition[1350]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" Dec 13 14:13:01.371013 ignition[1350]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Dec 13 14:13:01.397952 ignition[1350]: INFO : op(a): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2474383966" Dec 13 14:13:01.400667 ignition[1350]: CRITICAL : op(a): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2474383966": device or resource busy Dec 13 14:13:01.400667 ignition[1350]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2474383966", trying btrfs: device or resource busy Dec 13 14:13:01.400667 ignition[1350]: INFO : op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2474383966" Dec 13 14:13:01.400667 ignition[1350]: INFO : op(b): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2474383966" Dec 13 14:13:01.411732 ignition[1350]: INFO : op(c): [started] unmounting "/mnt/oem2474383966" Dec 13 14:13:01.413697 ignition[1350]: INFO : op(c): [finished] unmounting "/mnt/oem2474383966" Dec 13 14:13:01.415780 ignition[1350]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" Dec 13 14:13:01.419110 ignition[1350]: INFO : files: op(8): [started] processing unit "coreos-metadata-sshkeys@.service" Dec 13 14:13:01.419110 ignition[1350]: INFO : files: op(8): [finished] processing unit "coreos-metadata-sshkeys@.service" Dec 13 14:13:01.419110 ignition[1350]: INFO : files: op(9): [started] processing unit "amazon-ssm-agent.service" Dec 13 14:13:01.426219 ignition[1350]: INFO : files: op(9): op(a): [started] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service" Dec 13 14:13:01.429912 ignition[1350]: INFO : files: op(9): op(a): [finished] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service" Dec 13 14:13:01.429912 ignition[1350]: INFO : files: op(9): [finished] processing unit "amazon-ssm-agent.service" Dec 13 14:13:01.435694 ignition[1350]: INFO : files: op(b): [started] processing unit "nvidia.service" Dec 13 14:13:01.435694 ignition[1350]: INFO : files: op(b): [finished] processing unit "nvidia.service" Dec 13 14:13:01.435694 ignition[1350]: INFO : files: op(c): [started] processing unit "etcd-member.service" Dec 13 14:13:01.442197 ignition[1350]: INFO : files: op(c): op(d): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Dec 13 14:13:01.446298 ignition[1350]: INFO : files: op(c): op(d): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Dec 13 14:13:01.446298 ignition[1350]: INFO : files: op(c): [finished] processing unit "etcd-member.service" Dec 13 14:13:01.446298 ignition[1350]: INFO : files: op(e): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service " Dec 13 14:13:01.455384 ignition[1350]: INFO : files: op(e): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service " Dec 13 14:13:01.455384 ignition[1350]: INFO : files: op(f): [started] setting preset to enabled for "amazon-ssm-agent.service" Dec 13 14:13:01.455384 ignition[1350]: INFO : files: op(f): [finished] setting preset to enabled for "amazon-ssm-agent.service" Dec 13 14:13:01.455384 ignition[1350]: INFO : files: op(10): [started] setting preset to enabled for "nvidia.service" Dec 13 14:13:01.455384 ignition[1350]: INFO : files: op(10): [finished] setting preset to enabled for "nvidia.service" Dec 13 14:13:01.455384 ignition[1350]: INFO : files: op(11): [started] setting preset to enabled for "etcd-member.service" Dec 13 14:13:01.470576 ignition[1350]: INFO : files: op(11): [finished] setting preset to enabled for "etcd-member.service" Dec 13 14:13:01.481342 ignition[1350]: INFO : files: createResultFile: createFiles: op(12): [started] writing file "/sysroot/etc/.ignition-result.json" Dec 13 14:13:01.481342 ignition[1350]: INFO : files: createResultFile: createFiles: op(12): [finished] writing file "/sysroot/etc/.ignition-result.json" Dec 13 14:13:01.481342 ignition[1350]: INFO : files: files passed Dec 13 14:13:01.481342 ignition[1350]: INFO : Ignition finished successfully Dec 13 14:13:01.490681 systemd[1]: Finished ignition-files.service. Dec 13 14:13:01.492000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.501361 kernel: audit: type=1130 audit(1734099181.492:37): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.504772 systemd[1]: Starting initrd-setup-root-after-ignition.service... Dec 13 14:13:01.506540 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Dec 13 14:13:01.508106 systemd[1]: Starting ignition-quench.service... Dec 13 14:13:01.523196 systemd[1]: ignition-quench.service: Deactivated successfully. Dec 13 14:13:01.525055 systemd[1]: Finished ignition-quench.service. Dec 13 14:13:01.526000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.533000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.536351 kernel: audit: type=1130 audit(1734099181.526:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.537654 initrd-setup-root-after-ignition[1375]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 13 14:13:01.541931 systemd[1]: Finished initrd-setup-root-after-ignition.service. Dec 13 14:13:01.545578 systemd[1]: Reached target ignition-complete.target. Dec 13 14:13:01.544000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.549957 systemd[1]: Starting initrd-parse-etc.service... Dec 13 14:13:01.583239 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 13 14:13:01.585136 systemd[1]: Finished initrd-parse-etc.service. Dec 13 14:13:01.585000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.587000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.588522 systemd[1]: Reached target initrd-fs.target. Dec 13 14:13:01.591241 systemd[1]: Reached target initrd.target. Dec 13 14:13:01.593828 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Dec 13 14:13:01.597647 systemd[1]: Starting dracut-pre-pivot.service... Dec 13 14:13:01.621794 systemd[1]: Finished dracut-pre-pivot.service. Dec 13 14:13:01.623000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.626351 systemd[1]: Starting initrd-cleanup.service... Dec 13 14:13:01.646284 systemd[1]: Stopped target nss-lookup.target. Dec 13 14:13:01.649448 systemd[1]: Stopped target remote-cryptsetup.target. Dec 13 14:13:01.657211 systemd[1]: Stopped target timers.target. Dec 13 14:13:01.660649 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 13 14:13:01.662510 systemd[1]: Stopped dracut-pre-pivot.service. Dec 13 14:13:01.664000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.665712 systemd[1]: Stopped target initrd.target. Dec 13 14:13:01.668657 systemd[1]: Stopped target basic.target. Dec 13 14:13:01.675921 systemd[1]: Stopped target ignition-complete.target. Dec 13 14:13:01.679149 systemd[1]: Stopped target ignition-diskful.target. Dec 13 14:13:01.682976 systemd[1]: Stopped target initrd-root-device.target. Dec 13 14:13:01.690152 systemd[1]: Stopped target remote-fs.target. Dec 13 14:13:01.694093 systemd[1]: Stopped target remote-fs-pre.target. Dec 13 14:13:01.697067 systemd[1]: Stopped target sysinit.target. Dec 13 14:13:01.699969 systemd[1]: Stopped target local-fs.target. Dec 13 14:13:01.706922 systemd[1]: Stopped target local-fs-pre.target. Dec 13 14:13:01.709915 systemd[1]: Stopped target swap.target. Dec 13 14:13:01.716823 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 13 14:13:01.718658 systemd[1]: Stopped dracut-pre-mount.service. Dec 13 14:13:01.720000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.722087 systemd[1]: Stopped target cryptsetup.target. Dec 13 14:13:01.724992 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 13 14:13:01.726932 systemd[1]: Stopped dracut-initqueue.service. Dec 13 14:13:01.728000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.730018 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Dec 13 14:13:01.732271 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Dec 13 14:13:01.734000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.735808 systemd[1]: ignition-files.service: Deactivated successfully. Dec 13 14:13:01.737669 systemd[1]: Stopped ignition-files.service. Dec 13 14:13:01.739000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.748102 iscsid[1200]: iscsid shutting down. Dec 13 14:13:01.741997 systemd[1]: Stopping ignition-mount.service... Dec 13 14:13:01.748361 systemd[1]: Stopping iscsid.service... Dec 13 14:13:01.754000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.749673 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 13 14:13:01.750106 systemd[1]: Stopped kmod-static-nodes.service. Dec 13 14:13:01.763999 systemd[1]: Stopping sysroot-boot.service... Dec 13 14:13:01.773759 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 13 14:13:01.776170 ignition[1388]: INFO : Ignition 2.14.0 Dec 13 14:13:01.776170 ignition[1388]: INFO : Stage: umount Dec 13 14:13:01.776170 ignition[1388]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:13:01.776170 ignition[1388]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:13:01.779534 systemd[1]: Stopped systemd-udev-trigger.service. Dec 13 14:13:01.790000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.791985 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 13 14:13:01.794695 systemd[1]: Stopped dracut-pre-trigger.service. Dec 13 14:13:01.796000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.801345 ignition[1388]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:13:01.804636 ignition[1388]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:13:01.807550 ignition[1388]: INFO : PUT result: OK Dec 13 14:13:01.811969 ignition[1388]: INFO : umount: umount passed Dec 13 14:13:01.815223 ignition[1388]: INFO : Ignition finished successfully Dec 13 14:13:01.821621 systemd[1]: sysroot-boot.mount: Deactivated successfully. Dec 13 14:13:01.825033 systemd[1]: iscsid.service: Deactivated successfully. Dec 13 14:13:01.826899 systemd[1]: Stopped iscsid.service. Dec 13 14:13:01.828000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.830716 systemd[1]: ignition-mount.service: Deactivated successfully. Dec 13 14:13:01.832672 systemd[1]: Stopped ignition-mount.service. Dec 13 14:13:01.834000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.836553 systemd[1]: sysroot-boot.service: Deactivated successfully. Dec 13 14:13:01.838514 systemd[1]: Stopped sysroot-boot.service. Dec 13 14:13:01.840000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.843418 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 13 14:13:01.843614 systemd[1]: Finished initrd-cleanup.service. Dec 13 14:13:01.847000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.847000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.849737 systemd[1]: ignition-disks.service: Deactivated successfully. Dec 13 14:13:01.849849 systemd[1]: Stopped ignition-disks.service. Dec 13 14:13:01.851000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.854269 systemd[1]: ignition-kargs.service: Deactivated successfully. Dec 13 14:13:01.854389 systemd[1]: Stopped ignition-kargs.service. Dec 13 14:13:01.856000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.857511 systemd[1]: ignition-fetch.service: Deactivated successfully. Dec 13 14:13:01.858836 systemd[1]: Stopped ignition-fetch.service. Dec 13 14:13:01.862000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.863286 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Dec 13 14:13:01.863396 systemd[1]: Stopped ignition-fetch-offline.service. Dec 13 14:13:01.865000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.866876 systemd[1]: Stopped target paths.target. Dec 13 14:13:01.871019 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 13 14:13:01.873390 systemd[1]: Stopped systemd-ask-password-console.path. Dec 13 14:13:01.876521 systemd[1]: Stopped target slices.target. Dec 13 14:13:01.879044 systemd[1]: Stopped target sockets.target. Dec 13 14:13:01.881642 systemd[1]: iscsid.socket: Deactivated successfully. Dec 13 14:13:01.881715 systemd[1]: Closed iscsid.socket. Dec 13 14:13:01.884480 systemd[1]: ignition-setup.service: Deactivated successfully. Dec 13 14:13:01.887347 systemd[1]: Stopped ignition-setup.service. Dec 13 14:13:01.886000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.890064 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 13 14:13:01.890141 systemd[1]: Stopped initrd-setup-root.service. Dec 13 14:13:01.892000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.895716 systemd[1]: Stopping iscsiuio.service... Dec 13 14:13:01.901787 systemd[1]: iscsiuio.service: Deactivated successfully. Dec 13 14:13:01.903000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.901970 systemd[1]: Stopped iscsiuio.service. Dec 13 14:13:01.904796 systemd[1]: Stopped target network.target. Dec 13 14:13:01.906273 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 13 14:13:01.916000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.906362 systemd[1]: Closed iscsiuio.socket. Dec 13 14:13:01.907992 systemd[1]: Stopping systemd-networkd.service... Dec 13 14:13:01.909442 systemd[1]: Stopping systemd-resolved.service... Dec 13 14:13:01.913420 systemd-networkd[1195]: eth0: DHCPv6 lease lost Dec 13 14:13:01.926000 audit: BPF prog-id=9 op=UNLOAD Dec 13 14:13:01.915734 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 13 14:13:01.915933 systemd[1]: Stopped systemd-networkd.service. Dec 13 14:13:01.918905 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 13 14:13:01.918975 systemd[1]: Closed systemd-networkd.socket. Dec 13 14:13:01.924108 systemd[1]: Stopping network-cleanup.service... Dec 13 14:13:01.938966 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Dec 13 14:13:01.939000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.939102 systemd[1]: Stopped parse-ip-for-networkd.service. Dec 13 14:13:01.942000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.940830 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 13 14:13:01.940910 systemd[1]: Stopped systemd-sysctl.service. Dec 13 14:13:01.948560 systemd[1]: systemd-modules-load.service: Deactivated successfully. Dec 13 14:13:01.948656 systemd[1]: Stopped systemd-modules-load.service. Dec 13 14:13:01.950000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.953696 systemd[1]: Stopping systemd-udevd.service... Dec 13 14:13:01.966365 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Dec 13 14:13:01.969464 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 13 14:13:01.971264 systemd[1]: Stopped systemd-resolved.service. Dec 13 14:13:01.971000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.975396 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 13 14:13:01.977215 systemd[1]: Stopped systemd-udevd.service. Dec 13 14:13:01.978000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.981799 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 13 14:13:01.980000 audit: BPF prog-id=6 op=UNLOAD Dec 13 14:13:01.981899 systemd[1]: Closed systemd-udevd-control.socket. Dec 13 14:13:01.990000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.987592 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 13 14:13:01.993000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.996000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:02.009000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:01.987672 systemd[1]: Closed systemd-udevd-kernel.socket. Dec 13 14:13:01.989861 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 13 14:13:01.989951 systemd[1]: Stopped dracut-pre-udev.service. Dec 13 14:13:01.992039 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 13 14:13:01.992130 systemd[1]: Stopped dracut-cmdline.service. Dec 13 14:13:01.994516 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 13 14:13:01.994764 systemd[1]: Stopped dracut-cmdline-ask.service. Dec 13 14:13:01.998998 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Dec 13 14:13:02.006483 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 13 14:13:02.006617 systemd[1]: Stopped systemd-vconsole-setup.service. Dec 13 14:13:02.026000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:02.028000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:02.028000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:02.011300 systemd[1]: network-cleanup.service: Deactivated successfully. Dec 13 14:13:02.011696 systemd[1]: Stopped network-cleanup.service. Dec 13 14:13:02.028072 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 13 14:13:02.028265 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Dec 13 14:13:02.030293 systemd[1]: Reached target initrd-switch-root.target. Dec 13 14:13:02.039653 systemd[1]: Starting initrd-switch-root.service... Dec 13 14:13:02.061196 systemd[1]: Switching root. Dec 13 14:13:02.088618 systemd-journald[309]: Journal stopped Dec 13 14:13:06.770909 systemd-journald[309]: Received SIGTERM from PID 1 (systemd). Dec 13 14:13:06.772570 kernel: SELinux: Class mctp_socket not defined in policy. Dec 13 14:13:06.772629 kernel: SELinux: Class anon_inode not defined in policy. Dec 13 14:13:06.772669 kernel: SELinux: the above unknown classes and permissions will be allowed Dec 13 14:13:06.772701 kernel: SELinux: policy capability network_peer_controls=1 Dec 13 14:13:06.772734 kernel: SELinux: policy capability open_perms=1 Dec 13 14:13:06.772765 kernel: SELinux: policy capability extended_socket_class=1 Dec 13 14:13:06.772806 kernel: SELinux: policy capability always_check_network=0 Dec 13 14:13:06.772837 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 13 14:13:06.772867 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 13 14:13:06.772898 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 13 14:13:06.772932 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Dec 13 14:13:06.772967 systemd[1]: Successfully loaded SELinux policy in 91.817ms. Dec 13 14:13:06.773017 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 19.990ms. Dec 13 14:13:06.773054 systemd[1]: systemd 252 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) Dec 13 14:13:06.773087 systemd[1]: Detected virtualization amazon. Dec 13 14:13:06.773121 systemd[1]: Detected architecture arm64. Dec 13 14:13:06.773153 systemd[1]: Detected first boot. Dec 13 14:13:06.773185 systemd[1]: Initializing machine ID from VM UUID. Dec 13 14:13:06.773220 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Dec 13 14:13:06.773251 systemd[1]: Populated /etc with preset unit settings. Dec 13 14:13:06.773284 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Dec 13 14:13:06.773341 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Dec 13 14:13:06.773380 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Dec 13 14:13:06.773412 kernel: kauditd_printk_skb: 56 callbacks suppressed Dec 13 14:13:06.773443 kernel: audit: type=1334 audit(1734099186.389:88): prog-id=12 op=LOAD Dec 13 14:13:06.773474 kernel: audit: type=1334 audit(1734099186.390:89): prog-id=3 op=UNLOAD Dec 13 14:13:06.773511 kernel: audit: type=1334 audit(1734099186.391:90): prog-id=13 op=LOAD Dec 13 14:13:06.773542 kernel: audit: type=1334 audit(1734099186.394:91): prog-id=14 op=LOAD Dec 13 14:13:06.773571 kernel: audit: type=1334 audit(1734099186.394:92): prog-id=4 op=UNLOAD Dec 13 14:13:06.773600 kernel: audit: type=1334 audit(1734099186.394:93): prog-id=5 op=UNLOAD Dec 13 14:13:06.773632 kernel: audit: type=1334 audit(1734099186.396:94): prog-id=15 op=LOAD Dec 13 14:13:06.773661 kernel: audit: type=1334 audit(1734099186.396:95): prog-id=12 op=UNLOAD Dec 13 14:13:06.773690 kernel: audit: type=1334 audit(1734099186.398:96): prog-id=16 op=LOAD Dec 13 14:13:06.773723 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 13 14:13:06.773755 kernel: audit: type=1334 audit(1734099186.400:97): prog-id=17 op=LOAD Dec 13 14:13:06.773785 systemd[1]: Stopped initrd-switch-root.service. Dec 13 14:13:06.773816 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 13 14:13:06.773848 systemd[1]: Created slice system-addon\x2dconfig.slice. Dec 13 14:13:06.773880 systemd[1]: Created slice system-addon\x2drun.slice. Dec 13 14:13:06.773915 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice. Dec 13 14:13:06.773945 systemd[1]: Created slice system-getty.slice. Dec 13 14:13:06.773981 systemd[1]: Created slice system-modprobe.slice. Dec 13 14:13:06.774012 systemd[1]: Created slice system-serial\x2dgetty.slice. Dec 13 14:13:06.774048 systemd[1]: Created slice system-system\x2dcloudinit.slice. Dec 13 14:13:06.774078 systemd[1]: Created slice system-systemd\x2dfsck.slice. Dec 13 14:13:06.774108 systemd[1]: Created slice user.slice. Dec 13 14:13:06.774142 systemd[1]: Started systemd-ask-password-console.path. Dec 13 14:13:06.774175 systemd[1]: Started systemd-ask-password-wall.path. Dec 13 14:13:06.774206 systemd[1]: Set up automount boot.automount. Dec 13 14:13:06.774236 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Dec 13 14:13:06.774270 systemd[1]: Stopped target initrd-switch-root.target. Dec 13 14:13:06.774300 systemd[1]: Stopped target initrd-fs.target. Dec 13 14:13:06.774350 systemd[1]: Stopped target initrd-root-fs.target. Dec 13 14:13:06.774383 systemd[1]: Reached target integritysetup.target. Dec 13 14:13:06.774414 systemd[1]: Reached target remote-cryptsetup.target. Dec 13 14:13:06.774445 systemd[1]: Reached target remote-fs.target. Dec 13 14:13:06.774478 systemd[1]: Reached target slices.target. Dec 13 14:13:06.774508 systemd[1]: Reached target swap.target. Dec 13 14:13:06.774537 systemd[1]: Reached target torcx.target. Dec 13 14:13:06.774571 systemd[1]: Reached target veritysetup.target. Dec 13 14:13:06.774600 systemd[1]: Listening on systemd-coredump.socket. Dec 13 14:13:06.774630 systemd[1]: Listening on systemd-initctl.socket. Dec 13 14:13:06.774662 systemd[1]: Listening on systemd-networkd.socket. Dec 13 14:13:06.774692 systemd[1]: Listening on systemd-udevd-control.socket. Dec 13 14:13:06.774723 systemd[1]: Listening on systemd-udevd-kernel.socket. Dec 13 14:13:06.774753 systemd[1]: Listening on systemd-userdbd.socket. Dec 13 14:13:06.774785 systemd[1]: Mounting dev-hugepages.mount... Dec 13 14:13:06.774817 systemd[1]: Mounting dev-mqueue.mount... Dec 13 14:13:06.774850 systemd[1]: Mounting media.mount... Dec 13 14:13:06.774887 systemd[1]: Mounting sys-kernel-debug.mount... Dec 13 14:13:06.774919 systemd[1]: Mounting sys-kernel-tracing.mount... Dec 13 14:13:06.774948 systemd[1]: Mounting tmp.mount... Dec 13 14:13:06.774977 systemd[1]: Starting flatcar-tmpfiles.service... Dec 13 14:13:06.775006 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Dec 13 14:13:06.775035 systemd[1]: Starting kmod-static-nodes.service... Dec 13 14:13:06.775085 systemd[1]: Starting modprobe@configfs.service... Dec 13 14:13:06.775117 systemd[1]: Starting modprobe@dm_mod.service... Dec 13 14:13:06.775147 systemd[1]: Starting modprobe@drm.service... Dec 13 14:13:06.775180 systemd[1]: Starting modprobe@efi_pstore.service... Dec 13 14:13:06.775210 systemd[1]: Starting modprobe@fuse.service... Dec 13 14:13:06.775239 systemd[1]: Starting modprobe@loop.service... Dec 13 14:13:06.775271 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Dec 13 14:13:06.775301 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 13 14:13:06.775350 systemd[1]: Stopped systemd-fsck-root.service. Dec 13 14:13:06.775383 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 13 14:13:06.775416 systemd[1]: Stopped systemd-fsck-usr.service. Dec 13 14:13:06.775448 systemd[1]: Stopped systemd-journald.service. Dec 13 14:13:06.775482 systemd[1]: Starting systemd-journald.service... Dec 13 14:13:06.775512 systemd[1]: Starting systemd-modules-load.service... Dec 13 14:13:06.775544 systemd[1]: Starting systemd-network-generator.service... Dec 13 14:13:06.775574 systemd[1]: Starting systemd-remount-fs.service... Dec 13 14:13:06.775603 systemd[1]: Starting systemd-udev-trigger.service... Dec 13 14:13:06.775634 systemd[1]: verity-setup.service: Deactivated successfully. Dec 13 14:13:06.775663 systemd[1]: Stopped verity-setup.service. Dec 13 14:13:06.775692 kernel: loop: module loaded Dec 13 14:13:06.775723 systemd[1]: Mounted dev-hugepages.mount. Dec 13 14:13:06.775758 systemd[1]: Mounted dev-mqueue.mount. Dec 13 14:13:06.775789 systemd[1]: Mounted media.mount. Dec 13 14:13:06.775828 systemd[1]: Mounted sys-kernel-debug.mount. Dec 13 14:13:06.788519 systemd[1]: Mounted sys-kernel-tracing.mount. Dec 13 14:13:06.788554 systemd[1]: Mounted tmp.mount. Dec 13 14:13:06.788585 systemd[1]: Finished kmod-static-nodes.service. Dec 13 14:13:06.788617 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 13 14:13:06.788654 systemd[1]: Finished modprobe@configfs.service. Dec 13 14:13:06.788685 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 14:13:06.788722 systemd[1]: Finished modprobe@dm_mod.service. Dec 13 14:13:06.788753 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 13 14:13:06.788783 systemd[1]: Finished modprobe@drm.service. Dec 13 14:13:06.789637 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 14:13:06.791303 systemd[1]: Finished modprobe@efi_pstore.service. Dec 13 14:13:06.791387 kernel: fuse: init (API version 7.34) Dec 13 14:13:06.791421 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 14:13:06.791454 systemd[1]: Finished modprobe@loop.service. Dec 13 14:13:06.791496 systemd-journald[1504]: Journal started Dec 13 14:13:06.791624 systemd-journald[1504]: Runtime Journal (/run/log/journal/ec282c2491b11c5a559aaa6439e17a64) is 8.0M, max 75.4M, 67.4M free. Dec 13 14:13:02.474000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 13 14:13:02.593000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Dec 13 14:13:06.796190 systemd[1]: Finished systemd-network-generator.service. Dec 13 14:13:02.593000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Dec 13 14:13:02.593000 audit: BPF prog-id=10 op=LOAD Dec 13 14:13:02.593000 audit: BPF prog-id=10 op=UNLOAD Dec 13 14:13:02.593000 audit: BPF prog-id=11 op=LOAD Dec 13 14:13:02.593000 audit: BPF prog-id=11 op=UNLOAD Dec 13 14:13:02.732000 audit[1421]: AVC avc: denied { associate } for pid=1421 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023" Dec 13 14:13:02.732000 audit[1421]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=40001058dc a1=4000028e40 a2=4000027100 a3=32 items=0 ppid=1404 pid=1421 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 13 14:13:02.732000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Dec 13 14:13:02.736000 audit[1421]: AVC avc: denied { associate } for pid=1421 comm="torcx-generator" name="lib" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Dec 13 14:13:02.736000 audit[1421]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=40001059b5 a2=1ed a3=0 items=2 ppid=1404 pid=1421 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 13 14:13:02.736000 audit: CWD cwd="/" Dec 13 14:13:02.736000 audit: PATH item=0 name=(null) inode=2 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Dec 13 14:13:02.736000 audit: PATH item=1 name=(null) inode=3 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Dec 13 14:13:02.736000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Dec 13 14:13:06.389000 audit: BPF prog-id=12 op=LOAD Dec 13 14:13:06.390000 audit: BPF prog-id=3 op=UNLOAD Dec 13 14:13:06.391000 audit: BPF prog-id=13 op=LOAD Dec 13 14:13:06.394000 audit: BPF prog-id=14 op=LOAD Dec 13 14:13:06.394000 audit: BPF prog-id=4 op=UNLOAD Dec 13 14:13:06.394000 audit: BPF prog-id=5 op=UNLOAD Dec 13 14:13:06.396000 audit: BPF prog-id=15 op=LOAD Dec 13 14:13:06.396000 audit: BPF prog-id=12 op=UNLOAD Dec 13 14:13:06.398000 audit: BPF prog-id=16 op=LOAD Dec 13 14:13:06.400000 audit: BPF prog-id=17 op=LOAD Dec 13 14:13:06.400000 audit: BPF prog-id=13 op=UNLOAD Dec 13 14:13:06.400000 audit: BPF prog-id=14 op=UNLOAD Dec 13 14:13:06.405000 audit: BPF prog-id=18 op=LOAD Dec 13 14:13:06.405000 audit: BPF prog-id=15 op=UNLOAD Dec 13 14:13:06.407000 audit: BPF prog-id=19 op=LOAD Dec 13 14:13:06.410000 audit: BPF prog-id=20 op=LOAD Dec 13 14:13:06.410000 audit: BPF prog-id=16 op=UNLOAD Dec 13 14:13:06.410000 audit: BPF prog-id=17 op=UNLOAD Dec 13 14:13:06.411000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.420000 audit: BPF prog-id=18 op=UNLOAD Dec 13 14:13:06.420000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.420000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.650000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.800856 systemd[1]: Started systemd-journald.service. Dec 13 14:13:06.656000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.660000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.660000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.662000 audit: BPF prog-id=21 op=LOAD Dec 13 14:13:06.662000 audit: BPF prog-id=22 op=LOAD Dec 13 14:13:06.662000 audit: BPF prog-id=23 op=LOAD Dec 13 14:13:06.662000 audit: BPF prog-id=19 op=UNLOAD Dec 13 14:13:06.662000 audit: BPF prog-id=20 op=UNLOAD Dec 13 14:13:06.706000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.740000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.755000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.755000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.759000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Dec 13 14:13:06.759000 audit[1504]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=6 a1=ffffcc033790 a2=4000 a3=1 items=0 ppid=1 pid=1504 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 13 14:13:06.759000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Dec 13 14:13:06.763000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.763000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.771000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.771000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.780000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.780000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.790000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.790000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.794000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.798000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:02.729147 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3510.3.6 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.6 /var/lib/torcx/store]" Dec 13 14:13:06.388464 systemd[1]: Queued start job for default target multi-user.target. Dec 13 14:13:06.804000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.804000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.806000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.809000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:02.730274 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 13 14:13:06.412158 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 13 14:13:02.730352 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 13 14:13:06.800615 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 13 14:13:02.730423 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Dec 13 14:13:06.803535 systemd[1]: Finished modprobe@fuse.service. Dec 13 14:13:02.730449 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=debug msg="skipped missing lower profile" missing profile=oem Dec 13 14:13:06.806291 systemd[1]: Finished systemd-modules-load.service. Dec 13 14:13:02.730514 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Dec 13 14:13:06.808591 systemd[1]: Finished systemd-remount-fs.service. Dec 13 14:13:02.730545 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Dec 13 14:13:06.810941 systemd[1]: Reached target network-pre.target. Dec 13 14:13:02.730942 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Dec 13 14:13:06.814801 systemd[1]: Mounting sys-fs-fuse-connections.mount... Dec 13 14:13:02.731028 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 13 14:13:06.818692 systemd[1]: Mounting sys-kernel-config.mount... Dec 13 14:13:02.731082 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 13 14:13:06.824514 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Dec 13 14:13:02.732631 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Dec 13 14:13:02.732715 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Dec 13 14:13:02.732761 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.6: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.6 Dec 13 14:13:06.830119 systemd[1]: Starting systemd-hwdb-update.service... Dec 13 14:13:02.732801 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Dec 13 14:13:02.732847 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.6: no such file or directory" path=/var/lib/torcx/store/3510.3.6 Dec 13 14:13:02.732885 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:02Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Dec 13 14:13:05.582223 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:05Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 13 14:13:05.582775 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:05Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 13 14:13:05.583025 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:05Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 13 14:13:05.583523 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:05Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants /lib/systemd/system/multi-user.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 13 14:13:05.583642 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:05Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Dec 13 14:13:05.583781 /usr/lib/systemd/system-generators/torcx-generator[1421]: time="2024-12-13T14:13:05Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Dec 13 14:13:06.836000 systemd[1]: Starting systemd-journal-flush.service... Dec 13 14:13:06.837769 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 13 14:13:06.840361 systemd[1]: Starting systemd-random-seed.service... Dec 13 14:13:06.841993 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Dec 13 14:13:06.844885 systemd[1]: Starting systemd-sysctl.service... Dec 13 14:13:06.851667 systemd[1]: Mounted sys-fs-fuse-connections.mount. Dec 13 14:13:06.853682 systemd[1]: Mounted sys-kernel-config.mount. Dec 13 14:13:06.867076 systemd-journald[1504]: Time spent on flushing to /var/log/journal/ec282c2491b11c5a559aaa6439e17a64 is 50.119ms for 1118 entries. Dec 13 14:13:06.867076 systemd-journald[1504]: System Journal (/var/log/journal/ec282c2491b11c5a559aaa6439e17a64) is 8.0M, max 195.6M, 187.6M free. Dec 13 14:13:06.937831 systemd-journald[1504]: Received client request to flush runtime journal. Dec 13 14:13:06.890000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.907000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.889592 systemd[1]: Finished systemd-random-seed.service. Dec 13 14:13:06.891551 systemd[1]: Reached target first-boot-complete.target. Dec 13 14:13:06.907412 systemd[1]: Finished systemd-sysctl.service. Dec 13 14:13:06.939370 systemd[1]: Finished systemd-journal-flush.service. Dec 13 14:13:06.940000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.948000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:06.947539 systemd[1]: Finished flatcar-tmpfiles.service. Dec 13 14:13:06.951482 systemd[1]: Starting systemd-sysusers.service... Dec 13 14:13:07.025068 systemd[1]: Finished systemd-sysusers.service. Dec 13 14:13:07.025000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:07.036595 systemd[1]: Finished systemd-udev-trigger.service. Dec 13 14:13:07.037000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:07.040517 systemd[1]: Starting systemd-udev-settle.service... Dec 13 14:13:07.055506 udevadm[1540]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Dec 13 14:13:07.711903 systemd[1]: Finished systemd-hwdb-update.service. Dec 13 14:13:07.714000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:07.715000 audit: BPF prog-id=24 op=LOAD Dec 13 14:13:07.715000 audit: BPF prog-id=25 op=LOAD Dec 13 14:13:07.715000 audit: BPF prog-id=7 op=UNLOAD Dec 13 14:13:07.715000 audit: BPF prog-id=8 op=UNLOAD Dec 13 14:13:07.718055 systemd[1]: Starting systemd-udevd.service... Dec 13 14:13:07.755189 systemd-udevd[1541]: Using default interface naming scheme 'v252'. Dec 13 14:13:07.811279 systemd[1]: Started systemd-udevd.service. Dec 13 14:13:07.811000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:07.813000 audit: BPF prog-id=26 op=LOAD Dec 13 14:13:07.816012 systemd[1]: Starting systemd-networkd.service... Dec 13 14:13:07.823000 audit: BPF prog-id=27 op=LOAD Dec 13 14:13:07.823000 audit: BPF prog-id=28 op=LOAD Dec 13 14:13:07.823000 audit: BPF prog-id=29 op=LOAD Dec 13 14:13:07.826247 systemd[1]: Starting systemd-userdbd.service... Dec 13 14:13:07.904936 systemd[1]: Condition check resulted in dev-ttyS0.device being skipped. Dec 13 14:13:07.913809 systemd[1]: Started systemd-userdbd.service. Dec 13 14:13:07.914000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:07.950043 (udev-worker)[1547]: Network interface NamePolicy= disabled on kernel command line. Dec 13 14:13:08.074714 systemd-networkd[1548]: lo: Link UP Dec 13 14:13:08.074739 systemd-networkd[1548]: lo: Gained carrier Dec 13 14:13:08.075759 systemd-networkd[1548]: Enumeration completed Dec 13 14:13:08.076000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.075953 systemd[1]: Started systemd-networkd.service. Dec 13 14:13:08.079654 systemd-networkd[1548]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 13 14:13:08.080390 systemd[1]: Starting systemd-networkd-wait-online.service... Dec 13 14:13:08.088357 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Dec 13 14:13:08.093186 systemd-networkd[1548]: eth0: Link UP Dec 13 14:13:08.093528 systemd-networkd[1548]: eth0: Gained carrier Dec 13 14:13:08.129438 kernel: BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/nvme0n1p6 scanned by (udev-worker) (1572) Dec 13 14:13:08.132827 systemd-networkd[1548]: eth0: DHCPv4 address 172.31.24.189/20, gateway 172.31.16.1 acquired from 172.31.16.1 Dec 13 14:13:08.267785 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Dec 13 14:13:08.274492 systemd[1]: Finished systemd-udev-settle.service. Dec 13 14:13:08.274000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-settle comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.279139 systemd[1]: Starting lvm2-activation-early.service... Dec 13 14:13:08.306344 lvm[1661]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 13 14:13:08.346181 systemd[1]: Finished lvm2-activation-early.service. Dec 13 14:13:08.346000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.348159 systemd[1]: Reached target cryptsetup.target. Dec 13 14:13:08.352088 systemd[1]: Starting lvm2-activation.service... Dec 13 14:13:08.360529 lvm[1662]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 13 14:13:08.401001 systemd[1]: Finished lvm2-activation.service. Dec 13 14:13:08.401000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.402868 systemd[1]: Reached target local-fs-pre.target. Dec 13 14:13:08.404542 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Dec 13 14:13:08.404599 systemd[1]: Reached target local-fs.target. Dec 13 14:13:08.406150 systemd[1]: Reached target machines.target. Dec 13 14:13:08.409888 systemd[1]: Starting ldconfig.service... Dec 13 14:13:08.412449 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Dec 13 14:13:08.412589 systemd[1]: systemd-boot-system-token.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/LoaderFeatures-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Dec 13 14:13:08.415756 systemd[1]: Starting systemd-boot-update.service... Dec 13 14:13:08.420687 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Dec 13 14:13:08.429763 systemd[1]: Starting systemd-machine-id-commit.service... Dec 13 14:13:08.431705 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Dec 13 14:13:08.431840 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Dec 13 14:13:08.434405 systemd[1]: Starting systemd-tmpfiles-setup.service... Dec 13 14:13:08.449367 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1664 (bootctl) Dec 13 14:13:08.452141 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Dec 13 14:13:08.480999 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Dec 13 14:13:08.479000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-OEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.497448 systemd-tmpfiles[1667]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Dec 13 14:13:08.506200 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Dec 13 14:13:08.509145 systemd[1]: Finished systemd-machine-id-commit.service. Dec 13 14:13:08.507000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.511956 systemd-tmpfiles[1667]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Dec 13 14:13:08.524879 systemd-tmpfiles[1667]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Dec 13 14:13:08.570492 systemd-fsck[1672]: fsck.fat 4.2 (2021-01-31) Dec 13 14:13:08.570492 systemd-fsck[1672]: /dev/nvme0n1p1: 236 files, 117175/258078 clusters Dec 13 14:13:08.573849 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Dec 13 14:13:08.574000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.578507 systemd[1]: Mounting boot.mount... Dec 13 14:13:08.604528 systemd[1]: Mounted boot.mount. Dec 13 14:13:08.643581 systemd[1]: Finished systemd-boot-update.service. Dec 13 14:13:08.644000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-boot-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.883282 systemd[1]: Finished systemd-tmpfiles-setup.service. Dec 13 14:13:08.883000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.887960 systemd[1]: Starting audit-rules.service... Dec 13 14:13:08.891692 systemd[1]: Starting clean-ca-certificates.service... Dec 13 14:13:08.896822 systemd[1]: Starting systemd-journal-catalog-update.service... Dec 13 14:13:08.900000 audit: BPF prog-id=30 op=LOAD Dec 13 14:13:08.903975 systemd[1]: Starting systemd-resolved.service... Dec 13 14:13:08.905000 audit: BPF prog-id=31 op=LOAD Dec 13 14:13:08.909132 systemd[1]: Starting systemd-timesyncd.service... Dec 13 14:13:08.914718 systemd[1]: Starting systemd-update-utmp.service... Dec 13 14:13:08.928783 systemd[1]: Finished clean-ca-certificates.service. Dec 13 14:13:08.929000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=clean-ca-certificates comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.930801 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Dec 13 14:13:08.942000 audit[1692]: SYSTEM_BOOT pid=1692 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.948837 systemd[1]: Finished systemd-update-utmp.service. Dec 13 14:13:08.949000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.988000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:08.987596 systemd[1]: Finished systemd-journal-catalog-update.service. Dec 13 14:13:09.046000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Dec 13 14:13:09.046000 audit[1706]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffef7b6830 a2=420 a3=0 items=0 ppid=1686 pid=1706 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 13 14:13:09.046000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Dec 13 14:13:09.047861 augenrules[1706]: No rules Dec 13 14:13:09.049500 systemd[1]: Finished audit-rules.service. Dec 13 14:13:09.075632 systemd-resolved[1690]: Positive Trust Anchors: Dec 13 14:13:09.075659 systemd-resolved[1690]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 13 14:13:09.075712 systemd-resolved[1690]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Dec 13 14:13:09.094021 systemd[1]: Started systemd-timesyncd.service. Dec 13 14:13:09.095924 systemd[1]: Reached target time-set.target. Dec 13 14:13:09.108443 ldconfig[1663]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Dec 13 14:13:09.114640 systemd-resolved[1690]: Defaulting to hostname 'linux'. Dec 13 14:13:09.117002 systemd[1]: Finished ldconfig.service. Dec 13 14:13:09.120811 systemd[1]: Starting systemd-update-done.service... Dec 13 14:13:09.123139 systemd[1]: Started systemd-resolved.service. Dec 13 14:13:09.124972 systemd[1]: Reached target network.target. Dec 13 14:13:09.126511 systemd[1]: Reached target nss-lookup.target. Dec 13 14:13:09.142655 systemd[1]: Finished systemd-update-done.service. Dec 13 14:13:09.144516 systemd[1]: Reached target sysinit.target. Dec 13 14:13:09.146154 systemd[1]: Started motdgen.path. Dec 13 14:13:09.147579 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Dec 13 14:13:09.149870 systemd[1]: Started logrotate.timer. Dec 13 14:13:09.151462 systemd[1]: Started mdadm.timer. Dec 13 14:13:09.152737 systemd[1]: Started systemd-tmpfiles-clean.timer. Dec 13 14:13:09.154388 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Dec 13 14:13:09.154449 systemd[1]: Reached target paths.target. Dec 13 14:13:09.155825 systemd[1]: Reached target timers.target. Dec 13 14:13:09.157659 systemd[1]: Listening on dbus.socket. Dec 13 14:13:09.160945 systemd[1]: Starting docker.socket... Dec 13 14:13:09.167389 systemd[1]: Listening on sshd.socket. Dec 13 14:13:09.169050 systemd[1]: systemd-pcrphase-sysinit.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Dec 13 14:13:09.169921 systemd[1]: Listening on docker.socket. Dec 13 14:13:09.171562 systemd[1]: Reached target sockets.target. Dec 13 14:13:09.173116 systemd[1]: Reached target basic.target. Dec 13 14:13:09.174660 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Dec 13 14:13:09.174727 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Dec 13 14:13:09.176823 systemd[1]: Starting containerd.service... Dec 13 14:13:09.181986 systemd[1]: Starting coreos-metadata-sshkeys@core.service... Dec 13 14:13:09.186009 systemd[1]: Starting coreos-metadata.service... Dec 13 14:13:09.189841 systemd[1]: Starting dbus.service... Dec 13 14:13:09.194963 systemd[1]: Starting enable-oem-cloudinit.service... Dec 13 14:13:09.200867 systemd[1]: Starting extend-filesystems.service... Dec 13 14:13:09.203534 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Dec 13 14:13:09.206738 systemd[1]: Starting motdgen.service... Dec 13 14:13:09.211895 systemd[1]: Starting ssh-key-proc-cmdline.service... Dec 13 14:13:09.223565 jq[1719]: false Dec 13 14:13:09.216467 systemd[1]: Starting sshd-keygen.service... Dec 13 14:13:09.226491 systemd[1]: Starting systemd-logind.service... Dec 13 14:13:09.227990 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Dec 13 14:13:09.228118 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Dec 13 14:13:09.228988 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 13 14:13:09.230852 systemd[1]: Starting update-engine.service... Dec 13 14:13:09.235621 systemd[1]: Starting update-ssh-keys-after-ignition.service... Dec 13 14:13:09.245841 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Dec 13 14:13:09.246375 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Dec 13 14:13:09.248006 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 13 14:13:09.248385 systemd[1]: Finished ssh-key-proc-cmdline.service. Dec 13 14:13:09.265071 systemd[1]: Created slice system-sshd.slice. Dec 13 14:13:08.871426 systemd-timesyncd[1691]: Contacted time server 108.181.201.22:123 (0.flatcar.pool.ntp.org). Dec 13 14:13:09.000581 systemd-journald[1504]: Time jumped backwards, rotating. Dec 13 14:13:09.000704 jq[1729]: true Dec 13 14:13:09.000961 extend-filesystems[1720]: Found nvme0n1 Dec 13 14:13:09.000961 extend-filesystems[1720]: Found nvme0n1p1 Dec 13 14:13:09.000961 extend-filesystems[1720]: Found nvme0n1p2 Dec 13 14:13:09.000961 extend-filesystems[1720]: Found nvme0n1p3 Dec 13 14:13:09.000961 extend-filesystems[1720]: Found usr Dec 13 14:13:09.000961 extend-filesystems[1720]: Found nvme0n1p4 Dec 13 14:13:09.000961 extend-filesystems[1720]: Found nvme0n1p6 Dec 13 14:13:09.000961 extend-filesystems[1720]: Found nvme0n1p7 Dec 13 14:13:09.000961 extend-filesystems[1720]: Found nvme0n1p9 Dec 13 14:13:09.000961 extend-filesystems[1720]: Checking size of /dev/nvme0n1p9 Dec 13 14:13:08.935822 dbus-daemon[1718]: [system] SELinux support is enabled Dec 13 14:13:08.871529 systemd-timesyncd[1691]: Initial clock synchronization to Fri 2024-12-13 14:13:08.871212 UTC. Dec 13 14:13:09.027916 extend-filesystems[1720]: Resized partition /dev/nvme0n1p9 Dec 13 14:13:08.946041 dbus-daemon[1718]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1548 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Dec 13 14:13:08.872784 systemd-resolved[1690]: Clock change detected. Flushing caches. Dec 13 14:13:09.031079 jq[1736]: true Dec 13 14:13:09.031479 extend-filesystems[1766]: resize2fs 1.46.5 (30-Dec-2021) Dec 13 14:13:08.967676 dbus-daemon[1718]: [system] Successfully activated service 'org.freedesktop.systemd1' Dec 13 14:13:08.936164 systemd[1]: Started dbus.service. Dec 13 14:13:08.941088 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Dec 13 14:13:08.941160 systemd[1]: Reached target system-config.target. Dec 13 14:13:08.942909 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Dec 13 14:13:08.942941 systemd[1]: Reached target user-config.target. Dec 13 14:13:08.982928 systemd[1]: Starting systemd-hostnamed.service... Dec 13 14:13:08.998042 systemd[1]: motdgen.service: Deactivated successfully. Dec 13 14:13:08.998432 systemd[1]: Finished motdgen.service. Dec 13 14:13:09.053152 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Dec 13 14:13:09.106090 update_engine[1725]: I1213 14:13:09.105394 1725 main.cc:92] Flatcar Update Engine starting Dec 13 14:13:09.112792 systemd[1]: Started update-engine.service. Dec 13 14:13:09.117533 systemd[1]: Started locksmithd.service. Dec 13 14:13:09.162357 update_engine[1725]: I1213 14:13:09.119580 1725 update_check_scheduler.cc:74] Next update check in 7m24s Dec 13 14:13:09.166200 env[1734]: time="2024-12-13T14:13:09.164195489Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Dec 13 14:13:09.170145 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Dec 13 14:13:09.183247 extend-filesystems[1766]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Dec 13 14:13:09.183247 extend-filesystems[1766]: old_desc_blocks = 1, new_desc_blocks = 1 Dec 13 14:13:09.183247 extend-filesystems[1766]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Dec 13 14:13:09.190844 extend-filesystems[1720]: Resized filesystem in /dev/nvme0n1p9 Dec 13 14:13:09.192677 bash[1779]: Updated "/home/core/.ssh/authorized_keys" Dec 13 14:13:09.192662 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 13 14:13:09.193004 systemd[1]: Finished extend-filesystems.service. Dec 13 14:13:09.196713 systemd[1]: Finished update-ssh-keys-after-ignition.service. Dec 13 14:13:09.244436 systemd-logind[1724]: Watching system buttons on /dev/input/event0 (Power Button) Dec 13 14:13:09.247236 systemd-logind[1724]: Watching system buttons on /dev/input/event1 (Sleep Button) Dec 13 14:13:09.248984 systemd-logind[1724]: New seat seat0. Dec 13 14:13:09.260319 systemd[1]: Started systemd-logind.service. Dec 13 14:13:09.371022 env[1734]: time="2024-12-13T14:13:09.370958166Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Dec 13 14:13:09.375876 env[1734]: time="2024-12-13T14:13:09.375801270Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Dec 13 14:13:09.381647 dbus-daemon[1718]: [system] Successfully activated service 'org.freedesktop.hostname1' Dec 13 14:13:09.381882 systemd[1]: Started systemd-hostnamed.service. Dec 13 14:13:09.386705 dbus-daemon[1718]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1757 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Dec 13 14:13:09.388504 env[1734]: time="2024-12-13T14:13:09.388437222Z" 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/5.15.173-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Dec 13 14:13:09.388671 env[1734]: time="2024-12-13T14:13:09.388638258Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Dec 13 14:13:09.389204 env[1734]: time="2024-12-13T14:13:09.389158590Z" 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 Dec 13 14:13:09.389366 env[1734]: time="2024-12-13T14:13:09.389335038Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Dec 13 14:13:09.389488 env[1734]: time="2024-12-13T14:13:09.389456502Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Dec 13 14:13:09.389599 env[1734]: time="2024-12-13T14:13:09.389569230Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Dec 13 14:13:09.389888 env[1734]: time="2024-12-13T14:13:09.389854146Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Dec 13 14:13:09.390524 env[1734]: time="2024-12-13T14:13:09.390477078Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Dec 13 14:13:09.390910 env[1734]: time="2024-12-13T14:13:09.390867042Z" 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 Dec 13 14:13:09.391042 env[1734]: time="2024-12-13T14:13:09.391010635Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Dec 13 14:13:09.391312 env[1734]: time="2024-12-13T14:13:09.391274563Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Dec 13 14:13:09.391461 env[1734]: time="2024-12-13T14:13:09.391430659Z" level=info msg="metadata content store policy set" policy=shared Dec 13 14:13:09.391658 systemd[1]: Starting polkit.service... Dec 13 14:13:09.404795 env[1734]: time="2024-12-13T14:13:09.404733811Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Dec 13 14:13:09.405038 env[1734]: time="2024-12-13T14:13:09.405006103Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Dec 13 14:13:09.405183 env[1734]: time="2024-12-13T14:13:09.405150847Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Dec 13 14:13:09.405363 env[1734]: time="2024-12-13T14:13:09.405329947Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Dec 13 14:13:09.405586 env[1734]: time="2024-12-13T14:13:09.405554455Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Dec 13 14:13:09.405717 env[1734]: time="2024-12-13T14:13:09.405686803Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Dec 13 14:13:09.405863 env[1734]: time="2024-12-13T14:13:09.405832651Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Dec 13 14:13:09.406529 env[1734]: time="2024-12-13T14:13:09.406475647Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Dec 13 14:13:09.406704 env[1734]: time="2024-12-13T14:13:09.406673275Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Dec 13 14:13:09.406830 env[1734]: time="2024-12-13T14:13:09.406799431Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Dec 13 14:13:09.406952 env[1734]: time="2024-12-13T14:13:09.406922575Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Dec 13 14:13:09.407074 env[1734]: time="2024-12-13T14:13:09.407044531Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Dec 13 14:13:09.407436 env[1734]: time="2024-12-13T14:13:09.407399527Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Dec 13 14:13:09.407753 env[1734]: time="2024-12-13T14:13:09.407721595Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Dec 13 14:13:09.408509 env[1734]: time="2024-12-13T14:13:09.408471079Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Dec 13 14:13:09.408676 env[1734]: time="2024-12-13T14:13:09.408644839Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.408799 env[1734]: time="2024-12-13T14:13:09.408769819Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Dec 13 14:13:09.408995 env[1734]: time="2024-12-13T14:13:09.408965935Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.409232 env[1734]: time="2024-12-13T14:13:09.409200643Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.409382 env[1734]: time="2024-12-13T14:13:09.409353055Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.409501 env[1734]: time="2024-12-13T14:13:09.409470967Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.409630 env[1734]: time="2024-12-13T14:13:09.409600291Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.409747 env[1734]: time="2024-12-13T14:13:09.409718599Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.409860 env[1734]: time="2024-12-13T14:13:09.409831351Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.409978 env[1734]: time="2024-12-13T14:13:09.409949227Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.410136 env[1734]: time="2024-12-13T14:13:09.410090035Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Dec 13 14:13:09.410560 env[1734]: time="2024-12-13T14:13:09.410522251Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.414017 env[1734]: time="2024-12-13T14:13:09.413971135Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.414216 env[1734]: time="2024-12-13T14:13:09.414184327Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.419223 env[1734]: time="2024-12-13T14:13:09.419169655Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Dec 13 14:13:09.419414 env[1734]: time="2024-12-13T14:13:09.419377843Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Dec 13 14:13:09.419536 env[1734]: time="2024-12-13T14:13:09.419505343Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Dec 13 14:13:09.419665 env[1734]: time="2024-12-13T14:13:09.419633539Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Dec 13 14:13:09.419821 env[1734]: time="2024-12-13T14:13:09.419791555Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Dec 13 14:13:09.420365 env[1734]: time="2024-12-13T14:13:09.420259003Z" 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 BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 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.6 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} 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}" Dec 13 14:13:09.422274 env[1734]: time="2024-12-13T14:13:09.420779215Z" level=info msg="Connect containerd service" Dec 13 14:13:09.422274 env[1734]: time="2024-12-13T14:13:09.420849151Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Dec 13 14:13:09.422274 env[1734]: time="2024-12-13T14:13:09.422006107Z" 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" Dec 13 14:13:09.427610 env[1734]: time="2024-12-13T14:13:09.427561327Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 13 14:13:09.427877 env[1734]: time="2024-12-13T14:13:09.427827247Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 13 14:13:09.428076 env[1734]: time="2024-12-13T14:13:09.428048383Z" level=info msg="containerd successfully booted in 0.281461s" Dec 13 14:13:09.428198 systemd[1]: Started containerd.service. Dec 13 14:13:09.430774 env[1734]: time="2024-12-13T14:13:09.430712071Z" level=info msg="Start subscribing containerd event" Dec 13 14:13:09.434017 polkitd[1821]: Started polkitd version 121 Dec 13 14:13:09.437318 env[1734]: time="2024-12-13T14:13:09.437265559Z" level=info msg="Start recovering state" Dec 13 14:13:09.441338 env[1734]: time="2024-12-13T14:13:09.441288247Z" level=info msg="Start event monitor" Dec 13 14:13:09.441536 env[1734]: time="2024-12-13T14:13:09.441504763Z" level=info msg="Start snapshots syncer" Dec 13 14:13:09.441654 env[1734]: time="2024-12-13T14:13:09.441626167Z" level=info msg="Start cni network conf syncer for default" Dec 13 14:13:09.441765 env[1734]: time="2024-12-13T14:13:09.441737779Z" level=info msg="Start streaming server" Dec 13 14:13:09.459085 polkitd[1821]: Loading rules from directory /etc/polkit-1/rules.d Dec 13 14:13:09.459228 polkitd[1821]: Loading rules from directory /usr/share/polkit-1/rules.d Dec 13 14:13:09.461735 polkitd[1821]: Finished loading, compiling and executing 2 rules Dec 13 14:13:09.462499 dbus-daemon[1718]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Dec 13 14:13:09.462736 systemd[1]: Started polkit.service. Dec 13 14:13:09.465718 polkitd[1821]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Dec 13 14:13:09.484964 systemd-hostnamed[1757]: Hostname set to (transient) Dec 13 14:13:09.485323 systemd-resolved[1690]: System hostname changed to 'ip-172-31-24-189'. Dec 13 14:13:09.486895 coreos-metadata[1717]: Dec 13 14:13:09.486 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Dec 13 14:13:09.488180 coreos-metadata[1717]: Dec 13 14:13:09.488 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/instance-id: Attempt #1 Dec 13 14:13:09.488953 coreos-metadata[1717]: Dec 13 14:13:09.488 INFO Fetch successful Dec 13 14:13:09.488953 coreos-metadata[1717]: Dec 13 14:13:09.488 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/instance-type: Attempt #1 Dec 13 14:13:09.489636 coreos-metadata[1717]: Dec 13 14:13:09.489 INFO Fetch successful Dec 13 14:13:09.489636 coreos-metadata[1717]: Dec 13 14:13:09.489 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/local-ipv4: Attempt #1 Dec 13 14:13:09.490354 coreos-metadata[1717]: Dec 13 14:13:09.490 INFO Fetch successful Dec 13 14:13:09.490354 coreos-metadata[1717]: Dec 13 14:13:09.490 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-ipv4: Attempt #1 Dec 13 14:13:09.491204 coreos-metadata[1717]: Dec 13 14:13:09.491 INFO Fetch successful Dec 13 14:13:09.491204 coreos-metadata[1717]: Dec 13 14:13:09.491 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/placement/availability-zone: Attempt #1 Dec 13 14:13:09.492407 coreos-metadata[1717]: Dec 13 14:13:09.492 INFO Fetch successful Dec 13 14:13:09.492407 coreos-metadata[1717]: Dec 13 14:13:09.492 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/hostname: Attempt #1 Dec 13 14:13:09.493181 coreos-metadata[1717]: Dec 13 14:13:09.493 INFO Fetch successful Dec 13 14:13:09.493181 coreos-metadata[1717]: Dec 13 14:13:09.493 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-hostname: Attempt #1 Dec 13 14:13:09.493787 coreos-metadata[1717]: Dec 13 14:13:09.493 INFO Fetch successful Dec 13 14:13:09.493787 coreos-metadata[1717]: Dec 13 14:13:09.493 INFO Fetching http://169.254.169.254/2019-10-01/dynamic/instance-identity/document: Attempt #1 Dec 13 14:13:09.494370 coreos-metadata[1717]: Dec 13 14:13:09.494 INFO Fetch successful Dec 13 14:13:09.512342 systemd[1]: Finished coreos-metadata.service. Dec 13 14:13:09.644479 coreos-metadata[1716]: Dec 13 14:13:09.641 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Dec 13 14:13:09.649043 coreos-metadata[1716]: Dec 13 14:13:09.648 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys: Attempt #1 Dec 13 14:13:09.650051 coreos-metadata[1716]: Dec 13 14:13:09.649 INFO Fetch successful Dec 13 14:13:09.650319 systemd-networkd[1548]: eth0: Gained IPv6LL Dec 13 14:13:09.650707 coreos-metadata[1716]: Dec 13 14:13:09.650 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys/0/openssh-key: Attempt #1 Dec 13 14:13:09.652153 coreos-metadata[1716]: Dec 13 14:13:09.651 INFO Fetch successful Dec 13 14:13:09.660786 unknown[1716]: wrote ssh authorized keys file for user: core Dec 13 14:13:09.677639 systemd[1]: Finished systemd-networkd-wait-online.service. Dec 13 14:13:09.680870 systemd[1]: Reached target network-online.target. Dec 13 14:13:09.685087 systemd[1]: Started amazon-ssm-agent.service. Dec 13 14:13:09.690242 update-ssh-keys[1876]: Updated "/home/core/.ssh/authorized_keys" Dec 13 14:13:09.690101 systemd[1]: Starting etcd-member.service... Dec 13 14:13:09.695459 systemd[1]: Started nvidia.service. Dec 13 14:13:09.711064 systemd[1]: Finished coreos-metadata-sshkeys@core.service. Dec 13 14:13:09.951138 systemd[1]: Starting docker.service... Dec 13 14:13:09.982753 amazon-ssm-agent[1877]: 2024/12/13 14:13:09 Failed to load instance info from vault. RegistrationKey does not exist. Dec 13 14:13:09.985276 amazon-ssm-agent[1877]: Initializing new seelog logger Dec 13 14:13:09.985617 amazon-ssm-agent[1877]: New Seelog Logger Creation Complete Dec 13 14:13:09.985807 amazon-ssm-agent[1877]: 2024/12/13 14:13:09 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Dec 13 14:13:09.985807 amazon-ssm-agent[1877]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Dec 13 14:13:09.986746 amazon-ssm-agent[1877]: 2024/12/13 14:13:09 processing appconfig overrides Dec 13 14:13:10.050196 systemd[1]: nvidia.service: Deactivated successfully. Dec 13 14:13:10.134739 env[1909]: time="2024-12-13T14:13:10.134660790Z" level=info msg="Starting up" Dec 13 14:13:10.138079 env[1909]: time="2024-12-13T14:13:10.138027930Z" level=info msg="parsed scheme: \"unix\"" module=grpc Dec 13 14:13:10.138309 env[1909]: time="2024-12-13T14:13:10.138278550Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Dec 13 14:13:10.138678 env[1909]: time="2024-12-13T14:13:10.138640506Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Dec 13 14:13:10.138798 env[1909]: time="2024-12-13T14:13:10.138770394Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Dec 13 14:13:10.143546 env[1909]: time="2024-12-13T14:13:10.143491374Z" level=info msg="parsed scheme: \"unix\"" module=grpc Dec 13 14:13:10.143546 env[1909]: time="2024-12-13T14:13:10.143533002Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Dec 13 14:13:10.143766 env[1909]: time="2024-12-13T14:13:10.143569998Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Dec 13 14:13:10.143766 env[1909]: time="2024-12-13T14:13:10.143591922Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Dec 13 14:13:10.155961 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport3504067388-merged.mount: Deactivated successfully. Dec 13 14:13:10.214140 env[1909]: time="2024-12-13T14:13:10.213836479Z" level=info msg="Loading containers: start." Dec 13 14:13:10.360923 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Create new startup processor Dec 13 14:13:10.366824 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [LongRunningPluginsManager] registered plugins: {} Dec 13 14:13:10.366971 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Initializing bookkeeping folders Dec 13 14:13:10.366971 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO removing the completed state files Dec 13 14:13:10.366971 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Initializing bookkeeping folders for long running plugins Dec 13 14:13:10.367171 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Initializing replies folder for MDS reply requests that couldn't reach the service Dec 13 14:13:10.367171 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Initializing healthcheck folders for long running plugins Dec 13 14:13:10.367171 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Initializing locations for inventory plugin Dec 13 14:13:10.367171 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Initializing default location for custom inventory Dec 13 14:13:10.367396 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Initializing default location for file inventory Dec 13 14:13:10.367396 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Initializing default location for role inventory Dec 13 14:13:10.367396 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Init the cloudwatchlogs publisher Dec 13 14:13:10.367396 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Successfully loaded platform independent plugin aws:configureDocker Dec 13 14:13:10.367396 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Successfully loaded platform independent plugin aws:runDockerAction Dec 13 14:13:10.367644 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Successfully loaded platform independent plugin aws:runDocument Dec 13 14:13:10.367644 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Successfully loaded platform independent plugin aws:softwareInventory Dec 13 14:13:10.367644 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Successfully loaded platform independent plugin aws:runPowerShellScript Dec 13 14:13:10.367644 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Successfully loaded platform independent plugin aws:updateSsmAgent Dec 13 14:13:10.367644 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Successfully loaded platform independent plugin aws:refreshAssociation Dec 13 14:13:10.367644 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Successfully loaded platform independent plugin aws:configurePackage Dec 13 14:13:10.367964 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Successfully loaded platform independent plugin aws:downloadContent Dec 13 14:13:10.367964 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Successfully loaded platform dependent plugin aws:runShellScript Dec 13 14:13:10.367964 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO Starting Agent: amazon-ssm-agent - v2.3.1319.0 Dec 13 14:13:10.367964 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO OS: linux, Arch: arm64 Dec 13 14:13:10.375158 amazon-ssm-agent[1877]: datastore file /var/lib/amazon/ssm/i-0ea75d04a293f6600/longrunningplugins/datastore/store doesn't exist - no long running plugins to execute Dec 13 14:13:10.463451 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessageGatewayService] Starting session document processing engine... Dec 13 14:13:10.483278 locksmithd[1781]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 13 14:13:10.504145 kernel: Initializing XFRM netlink socket Dec 13 14:13:10.550798 env[1909]: time="2024-12-13T14:13:10.550733720Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Dec 13 14:13:10.553924 (udev-worker)[1542]: Network interface NamePolicy= disabled on kernel command line. Dec 13 14:13:10.559185 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessageGatewayService] [EngineProcessor] Starting Dec 13 14:13:10.652585 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessageGatewayService] SSM Agent is trying to setup control channel for Session Manager module. Dec 13 14:13:10.655528 systemd-networkd[1548]: docker0: Link UP Dec 13 14:13:10.677510 env[1909]: time="2024-12-13T14:13:10.677461665Z" level=info msg="Loading containers: done." Dec 13 14:13:10.705544 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3914143350-merged.mount: Deactivated successfully. Dec 13 14:13:10.718058 env[1909]: time="2024-12-13T14:13:10.718001217Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Dec 13 14:13:10.718717 env[1909]: time="2024-12-13T14:13:10.718686477Z" level=info msg="Docker daemon" commit=112bdf3343 graphdriver(s)=overlay2 version=20.10.23 Dec 13 14:13:10.719079 env[1909]: time="2024-12-13T14:13:10.719053305Z" level=info msg="Daemon has completed initialization" Dec 13 14:13:10.747253 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessageGatewayService] Setting up websocket for controlchannel for instance: i-0ea75d04a293f6600, requestId: e8dde2ac-ecd4-4ae0-b5bb-0560e4521322 Dec 13 14:13:10.748378 systemd[1]: Started docker.service. Dec 13 14:13:10.758987 env[1909]: time="2024-12-13T14:13:10.758891997Z" level=info msg="API listen on /run/docker.sock" Dec 13 14:13:10.761035 etcd-wrapper[1889]: Error response from daemon: No such container: etcd-member Dec 13 14:13:10.804752 etcd-wrapper[2034]: Error: No such container: etcd-member Dec 13 14:13:10.841846 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessagingDeliveryService] Starting document processing engine... Dec 13 14:13:10.882606 etcd-wrapper[2050]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally Dec 13 14:13:10.936763 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessagingDeliveryService] [EngineProcessor] Starting Dec 13 14:13:11.031979 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessagingDeliveryService] [EngineProcessor] Initial processing Dec 13 14:13:11.127255 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessagingDeliveryService] Starting message polling Dec 13 14:13:11.222789 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessagingDeliveryService] Starting send replies to MDS Dec 13 14:13:11.318534 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [instanceID=i-0ea75d04a293f6600] Starting association polling Dec 13 14:13:11.414355 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessagingDeliveryService] [Association] [EngineProcessor] Starting Dec 13 14:13:11.510454 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessagingDeliveryService] [Association] Launching response handler Dec 13 14:13:11.606813 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessagingDeliveryService] [Association] [EngineProcessor] Initial processing Dec 13 14:13:11.703236 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessagingDeliveryService] [Association] Initializing association scheduling service Dec 13 14:13:11.799920 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessagingDeliveryService] [Association] Association scheduling service initialized Dec 13 14:13:11.896825 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessageGatewayService] listening reply. Dec 13 14:13:11.993824 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [HealthCheck] HealthCheck reporting agent health. Dec 13 14:13:12.091047 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [OfflineService] Starting document processing engine... Dec 13 14:13:12.188562 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [OfflineService] [EngineProcessor] Starting Dec 13 14:13:12.286208 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [OfflineService] [EngineProcessor] Initial processing Dec 13 14:13:12.384076 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [OfflineService] Starting message polling Dec 13 14:13:12.482193 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [OfflineService] Starting send replies to MDS Dec 13 14:13:12.525408 sshd_keygen[1752]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Dec 13 14:13:12.561579 systemd[1]: Finished sshd-keygen.service. Dec 13 14:13:12.566225 systemd[1]: Starting issuegen.service... Dec 13 14:13:12.569949 systemd[1]: Started sshd@0-172.31.24.189:22-139.178.89.65:56868.service. Dec 13 14:13:12.579356 systemd[1]: issuegen.service: Deactivated successfully. Dec 13 14:13:12.579694 systemd[1]: Finished issuegen.service. Dec 13 14:13:12.584307 systemd[1]: Starting systemd-user-sessions.service... Dec 13 14:13:12.587063 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [LongRunningPluginsManager] starting long running plugin manager Dec 13 14:13:12.599708 systemd[1]: Finished systemd-user-sessions.service. Dec 13 14:13:12.604339 systemd[1]: Started getty@tty1.service. Dec 13 14:13:12.609523 systemd[1]: Started serial-getty@ttyS0.service. Dec 13 14:13:12.611631 systemd[1]: Reached target getty.target. Dec 13 14:13:12.685637 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [LongRunningPluginsManager] there aren't any long running plugin to execute Dec 13 14:13:12.784308 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [LongRunningPluginsManager] There are no long running plugins currently getting executed - skipping their healthcheck Dec 13 14:13:12.796219 sshd[2064]: Accepted publickey for core from 139.178.89.65 port 56868 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:13:12.801950 sshd[2064]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:12.824549 systemd[1]: Created slice user-500.slice. Dec 13 14:13:12.829095 systemd[1]: Starting user-runtime-dir@500.service... Dec 13 14:13:12.840482 systemd-logind[1724]: New session 1 of user core. Dec 13 14:13:12.850816 systemd[1]: Finished user-runtime-dir@500.service. Dec 13 14:13:12.857059 systemd[1]: Starting user@500.service... Dec 13 14:13:12.866014 (systemd)[2072]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:12.883189 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [StartupProcessor] Executing startup processor tasks Dec 13 14:13:12.982245 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [StartupProcessor] Write to serial port: Amazon SSM Agent v2.3.1319.0 is running Dec 13 14:13:13.081550 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [StartupProcessor] Write to serial port: OsProductName: Flatcar Container Linux by Kinvolk Dec 13 14:13:13.089125 systemd[2072]: Queued start job for default target default.target. Dec 13 14:13:13.090184 systemd[2072]: Reached target paths.target. Dec 13 14:13:13.090237 systemd[2072]: Reached target sockets.target. Dec 13 14:13:13.090270 systemd[2072]: Reached target timers.target. Dec 13 14:13:13.090299 systemd[2072]: Reached target basic.target. Dec 13 14:13:13.090454 systemd[1]: Started user@500.service. Dec 13 14:13:13.091546 systemd[2072]: Reached target default.target. Dec 13 14:13:13.091622 systemd[2072]: Startup finished in 213ms. Dec 13 14:13:13.094289 systemd[1]: Started session-1.scope. Dec 13 14:13:13.180934 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [StartupProcessor] Write to serial port: OsVersion: 3510.3.6 Dec 13 14:13:13.241508 systemd[1]: Started sshd@1-172.31.24.189:22-139.178.89.65:56878.service. Dec 13 14:13:13.280777 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessageGatewayService] Opening websocket connection to: wss://ssmmessages.us-west-2.amazonaws.com/v1/control-channel/i-0ea75d04a293f6600?role=subscribe&stream=input Dec 13 14:13:13.380629 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessageGatewayService] Successfully opened websocket connection to: wss://ssmmessages.us-west-2.amazonaws.com/v1/control-channel/i-0ea75d04a293f6600?role=subscribe&stream=input Dec 13 14:13:13.417716 sshd[2081]: Accepted publickey for core from 139.178.89.65 port 56878 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:13:13.420184 sshd[2081]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:13.428445 systemd-logind[1724]: New session 2 of user core. Dec 13 14:13:13.429489 systemd[1]: Started session-2.scope. Dec 13 14:13:13.480591 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessageGatewayService] Starting receiving message from control channel Dec 13 14:13:13.565193 sshd[2081]: pam_unix(sshd:session): session closed for user core Dec 13 14:13:13.570300 systemd-logind[1724]: Session 2 logged out. Waiting for processes to exit. Dec 13 14:13:13.571673 systemd[1]: sshd@1-172.31.24.189:22-139.178.89.65:56878.service: Deactivated successfully. Dec 13 14:13:13.572972 systemd[1]: session-2.scope: Deactivated successfully. Dec 13 14:13:13.574447 systemd-logind[1724]: Removed session 2. Dec 13 14:13:13.580854 amazon-ssm-agent[1877]: 2024-12-13 14:13:10 INFO [MessageGatewayService] [EngineProcessor] Initial processing Dec 13 14:13:13.594987 systemd[1]: Started sshd@2-172.31.24.189:22-139.178.89.65:56890.service. Dec 13 14:13:13.717503 etcd-wrapper[2050]: v3.5.16: Pulling from coreos/etcd Dec 13 14:13:13.764639 sshd[2088]: Accepted publickey for core from 139.178.89.65 port 56890 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:13:13.767527 sshd[2088]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:13.775074 systemd-logind[1724]: New session 3 of user core. Dec 13 14:13:13.776057 systemd[1]: Started session-3.scope. Dec 13 14:13:13.906448 sshd[2088]: pam_unix(sshd:session): session closed for user core Dec 13 14:13:13.910633 systemd[1]: session-3.scope: Deactivated successfully. Dec 13 14:13:13.911777 systemd-logind[1724]: Session 3 logged out. Waiting for processes to exit. Dec 13 14:13:13.912205 systemd[1]: sshd@2-172.31.24.189:22-139.178.89.65:56890.service: Deactivated successfully. Dec 13 14:13:13.915220 systemd-logind[1724]: Removed session 3. Dec 13 14:13:13.951527 etcd-wrapper[2050]: d10f96ed9607: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: 2ae710cd8bfe: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: d462aa345367: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: 0f8b424aa0b9: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: d557676654e5: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: c8022d07192e: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: d858cbc252ad: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: 1069fc2daed1: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: b40161cd83fc: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: 5318d93a3a65: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: 307c1adadb60: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: f9b3c65df792: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: 5709b4a82c35: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: d5372e382b07: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: 9c3b5253dddc: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: 7a57323f7551: Pulling fs layer Dec 13 14:13:13.951527 etcd-wrapper[2050]: c8022d07192e: Waiting Dec 13 14:13:13.951527 etcd-wrapper[2050]: d858cbc252ad: Waiting Dec 13 14:13:13.951527 etcd-wrapper[2050]: 1069fc2daed1: Waiting Dec 13 14:13:13.951527 etcd-wrapper[2050]: b40161cd83fc: Waiting Dec 13 14:13:13.951527 etcd-wrapper[2050]: 0f8b424aa0b9: Waiting Dec 13 14:13:13.951527 etcd-wrapper[2050]: 5318d93a3a65: Waiting Dec 13 14:13:13.952689 etcd-wrapper[2050]: d557676654e5: Waiting Dec 13 14:13:13.952689 etcd-wrapper[2050]: 307c1adadb60: Waiting Dec 13 14:13:13.952689 etcd-wrapper[2050]: f9b3c65df792: Waiting Dec 13 14:13:13.952689 etcd-wrapper[2050]: 7a57323f7551: Waiting Dec 13 14:13:13.952689 etcd-wrapper[2050]: d5372e382b07: Waiting Dec 13 14:13:13.952689 etcd-wrapper[2050]: 9c3b5253dddc: Waiting Dec 13 14:13:13.952689 etcd-wrapper[2050]: 5709b4a82c35: Waiting Dec 13 14:13:14.507009 etcd-wrapper[2050]: 0f8b424aa0b9: Download complete Dec 13 14:13:14.774429 etcd-wrapper[2050]: d557676654e5: Verifying Checksum Dec 13 14:13:14.775138 etcd-wrapper[2050]: d557676654e5: Download complete Dec 13 14:13:15.027206 etcd-wrapper[2050]: d462aa345367: Download complete Dec 13 14:13:15.031416 etcd-wrapper[2050]: d10f96ed9607: Verifying Checksum Dec 13 14:13:15.031673 etcd-wrapper[2050]: d10f96ed9607: Download complete Dec 13 14:13:15.053100 etcd-wrapper[2050]: c8022d07192e: Verifying Checksum Dec 13 14:13:15.053279 etcd-wrapper[2050]: c8022d07192e: Download complete Dec 13 14:13:15.166556 etcd-wrapper[2050]: d10f96ed9607: Pull complete Dec 13 14:13:15.252738 systemd[1]: var-lib-docker-overlay2-ec6d474cff085c168a3581c1d4fd24c9bf09d16ef76fa11cd59208e96f667045-merged.mount: Deactivated successfully. Dec 13 14:13:15.276556 etcd-wrapper[2050]: 2ae710cd8bfe: Pull complete Dec 13 14:13:15.482403 etcd-wrapper[2050]: b40161cd83fc: Verifying Checksum Dec 13 14:13:15.484487 etcd-wrapper[2050]: b40161cd83fc: Download complete Dec 13 14:13:15.491300 etcd-wrapper[2050]: d858cbc252ad: Verifying Checksum Dec 13 14:13:15.491476 etcd-wrapper[2050]: d858cbc252ad: Download complete Dec 13 14:13:15.748827 etcd-wrapper[2050]: 307c1adadb60: Verifying Checksum Dec 13 14:13:15.748827 etcd-wrapper[2050]: 307c1adadb60: Download complete Dec 13 14:13:15.828858 etcd-wrapper[2050]: 5318d93a3a65: Verifying Checksum Dec 13 14:13:15.828858 etcd-wrapper[2050]: 5318d93a3a65: Download complete Dec 13 14:13:15.853241 systemd[1]: var-lib-docker-overlay2-b9ddcc7f5ceff2c5be0b6fcfd9fb88f09a7f28ca148fde78fbad02d7e52c697a-merged.mount: Deactivated successfully. Dec 13 14:13:15.903958 etcd-wrapper[2050]: d462aa345367: Pull complete Dec 13 14:13:16.001961 etcd-wrapper[2050]: 0f8b424aa0b9: Pull complete Dec 13 14:13:16.100057 etcd-wrapper[2050]: d557676654e5: Pull complete Dec 13 14:13:16.175349 systemd[1]: var-lib-docker-overlay2-0742d5b5a3ef1288001de8e0f6e6287fb46ccc235645f8b50f5b7caf6792c0f1-merged.mount: Deactivated successfully. Dec 13 14:13:16.212778 systemd[1]: var-lib-docker-overlay2-40d44737526f0fbaf6cee96e455a39112b107e6d3f86b2a7d0bbae324e35943f-merged.mount: Deactivated successfully. Dec 13 14:13:16.274802 etcd-wrapper[2050]: c8022d07192e: Pull complete Dec 13 14:13:16.308018 etcd-wrapper[2050]: f9b3c65df792: Verifying Checksum Dec 13 14:13:16.308018 etcd-wrapper[2050]: f9b3c65df792: Download complete Dec 13 14:13:16.383942 systemd[1]: var-lib-docker-overlay2-92c1172d84104155226196f5d267434f872f4f43f2aaaef4330560818ab12ee6-merged.mount: Deactivated successfully. Dec 13 14:13:16.422217 etcd-wrapper[2050]: d858cbc252ad: Pull complete Dec 13 14:13:16.422436 etcd-wrapper[2050]: 5709b4a82c35: Verifying Checksum Dec 13 14:13:16.422436 etcd-wrapper[2050]: 5709b4a82c35: Download complete Dec 13 14:13:16.440427 etcd-wrapper[2050]: 1069fc2daed1: Verifying Checksum Dec 13 14:13:16.440590 etcd-wrapper[2050]: 1069fc2daed1: Download complete Dec 13 14:13:16.540865 etcd-wrapper[2050]: 1069fc2daed1: Pull complete Dec 13 14:13:16.634472 etcd-wrapper[2050]: b40161cd83fc: Pull complete Dec 13 14:13:16.714748 etcd-wrapper[2050]: 9c3b5253dddc: Verifying Checksum Dec 13 14:13:16.715014 etcd-wrapper[2050]: 9c3b5253dddc: Download complete Dec 13 14:13:16.733778 etcd-wrapper[2050]: 7a57323f7551: Verifying Checksum Dec 13 14:13:16.733958 etcd-wrapper[2050]: 7a57323f7551: Download complete Dec 13 14:13:16.780255 etcd-wrapper[2050]: 5318d93a3a65: Pull complete Dec 13 14:13:16.890923 etcd-wrapper[2050]: d5372e382b07: Verifying Checksum Dec 13 14:13:16.891927 etcd-wrapper[2050]: d5372e382b07: Download complete Dec 13 14:13:16.915911 etcd-wrapper[2050]: 307c1adadb60: Pull complete Dec 13 14:13:17.175381 systemd[1]: var-lib-docker-overlay2-364f26cc6138b383768e70e0c22d92f4c0704cb33832f6d58c657123aa72f8af-merged.mount: Deactivated successfully. Dec 13 14:13:17.425094 systemd[1]: var-lib-docker-overlay2-501961bbf0e1b4698dae36dbedc09d9b472ed3d4f5aaa6beaf6624514e5deaff-merged.mount: Deactivated successfully. Dec 13 14:13:17.489137 etcd-wrapper[2050]: f9b3c65df792: Pull complete Dec 13 14:13:17.890132 systemd[1]: var-lib-docker-overlay2-42eca6b0c2026305450b44ea4417acc935bc3259e3e446cefd1a2b7edd7a04d6-merged.mount: Deactivated successfully. Dec 13 14:13:17.950217 etcd-wrapper[2050]: 5709b4a82c35: Pull complete Dec 13 14:13:18.301564 systemd[1]: var-lib-docker-overlay2-5109b6640486ff48bf9e4324e406970a181bdd331ef247d4f84cd20960eb1f84-merged.mount: Deactivated successfully. Dec 13 14:13:18.365537 etcd-wrapper[2050]: d5372e382b07: Pull complete Dec 13 14:13:18.458641 systemd[1]: var-lib-docker-overlay2-01d7112b970b9fe67afc80b93c2fba1083abde88bc56f8a6af7e4c74173d7304-merged.mount: Deactivated successfully. Dec 13 14:13:18.476451 etcd-wrapper[2050]: 9c3b5253dddc: Pull complete Dec 13 14:13:18.565749 systemd[1]: var-lib-docker-overlay2-914bd7695acd8e0b51b72f800c1107b80bf5e0a090269465323dad6a17a63de9-merged.mount: Deactivated successfully. Dec 13 14:13:18.581162 etcd-wrapper[2050]: 7a57323f7551: Pull complete Dec 13 14:13:18.594901 etcd-wrapper[2050]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159 Dec 13 14:13:18.599134 etcd-wrapper[2050]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16 Dec 13 14:13:18.766728 env[1734]: time="2024-12-13T14:13:18.766581341Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Dec 13 14:13:18.766728 env[1734]: time="2024-12-13T14:13:18.766661381Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Dec 13 14:13:18.766728 env[1734]: time="2024-12-13T14:13:18.766688405Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Dec 13 14:13:18.767869 env[1734]: time="2024-12-13T14:13:18.767762357Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/557aa52fd607024a83eb7f498a303fdeb34fbc75e1509439eb71d9b5604f6fb3 pid=2208 runtime=io.containerd.runc.v2 Dec 13 14:13:18.790183 systemd[1]: Started docker-557aa52fd607024a83eb7f498a303fdeb34fbc75e1509439eb71d9b5604f6fb3.scope. Dec 13 14:13:18.884554 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.884025Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Dec 13 14:13:18.884554 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.884362Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec282c2491b11c5a559aaa6439e17a64"} Dec 13 14:13:18.885305 etcd-wrapper[2050]: {"level":"warn","ts":"2024-12-13T14:13:18.885003Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Dec 13 14:13:18.885305 etcd-wrapper[2050]: {"level":"warn","ts":"2024-12-13T14:13:18.885089Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"} Dec 13 14:13:18.885685 etcd-wrapper[2050]: {"level":"warn","ts":"2024-12-13T14:13:18.885179Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Dec 13 14:13:18.885685 etcd-wrapper[2050]: {"level":"warn","ts":"2024-12-13T14:13:18.885556Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Dec 13 14:13:18.886202 etcd-wrapper[2050]: {"level":"warn","ts":"2024-12-13T14:13:18.885956Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Dec 13 14:13:18.886202 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.886044Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://172.31.24.189:2379"]} Dec 13 14:13:18.886726 etcd-wrapper[2050]: {"level":"warn","ts":"2024-12-13T14:13:18.886500Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Dec 13 14:13:18.886726 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.886584Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Dec 13 14:13:18.887955 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.887663Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Dec 13 14:13:18.888665 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.888340Z","caller":"embed/etcd.go:311","msg":"starting an etcd server","etcd-version":"3.5.16","git-sha":"f20bbad","go-version":"go1.22.7","go-os":"linux","go-arch":"arm64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"ec282c2491b11c5a559aaa6439e17a64","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://172.31.24.189:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec282c2491b11c5a559aaa6439e17a64=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} Dec 13 14:13:18.892513 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.892193Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.886228ms"} Dec 13 14:13:18.900479 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.900147Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Dec 13 14:13:18.900936 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.900472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Dec 13 14:13:18.900936 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.900542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Dec 13 14:13:18.900936 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.900564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Dec 13 14:13:18.900936 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.900581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Dec 13 14:13:18.900936 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.900635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Dec 13 14:13:18.904855 etcd-wrapper[2050]: {"level":"warn","ts":"2024-12-13T14:13:18.904565Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Dec 13 14:13:18.906727 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.906442Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Dec 13 14:13:18.908145 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.907846Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} Dec 13 14:13:18.909071 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.908776Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Dec 13 14:13:18.909590 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.909304Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Dec 13 14:13:18.910100 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.909823Z","caller":"etcdserver/server.go:757","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Dec 13 14:13:18.910590 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.910338Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Dec 13 14:13:18.910590 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.910445Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Dec 13 14:13:18.910990 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.910769Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Dec 13 14:13:18.911626 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.911365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Dec 13 14:13:18.912792 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.912485Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} Dec 13 14:13:18.915749 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.915419Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"} Dec 13 14:13:18.915749 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.915469Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"} Dec 13 14:13:18.916252 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:18.915607Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://172.31.24.189:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Dec 13 14:13:19.101853 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.101574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Dec 13 14:13:19.101853 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.101681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Dec 13 14:13:19.102787 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.102541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Dec 13 14:13:19.102787 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.102646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Dec 13 14:13:19.103189 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.102936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Dec 13 14:13:19.103189 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.103018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Dec 13 14:13:19.103576 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.103356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Dec 13 14:13:19.106871 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.106539Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Dec 13 14:13:19.107553 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.107254Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:ec282c2491b11c5a559aaa6439e17a64 ClientURLs:[http://172.31.24.189:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Dec 13 14:13:19.107553 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.107304Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Dec 13 14:13:19.107822 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.107577Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Dec 13 14:13:19.108051 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.107862Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Dec 13 14:13:19.108367 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.108059Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Dec 13 14:13:19.108831 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.108589Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Dec 13 14:13:19.109292 systemd[1]: Started etcd-member.service. Dec 13 14:13:19.109871 systemd[1]: Reached target multi-user.target. Dec 13 14:13:19.112689 systemd[1]: Starting systemd-update-utmp-runlevel.service... Dec 13 14:13:19.113951 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.109017Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Dec 13 14:13:19.113951 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.110901Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Dec 13 14:13:19.113951 etcd-wrapper[2050]: {"level":"info","ts":"2024-12-13T14:13:19.111581Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Dec 13 14:13:19.127607 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Dec 13 14:13:19.128042 systemd[1]: Finished systemd-update-utmp-runlevel.service. Dec 13 14:13:19.128437 systemd[1]: Startup finished in 1.125s (kernel) + 6.781s (initrd) + 17.159s (userspace) = 25.066s. Dec 13 14:13:23.935046 systemd[1]: Started sshd@3-172.31.24.189:22-139.178.89.65:54320.service. Dec 13 14:13:24.104345 sshd[2250]: Accepted publickey for core from 139.178.89.65 port 54320 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:13:24.107381 sshd[2250]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:24.115283 systemd-logind[1724]: New session 4 of user core. Dec 13 14:13:24.116175 systemd[1]: Started session-4.scope. Dec 13 14:13:24.244894 sshd[2250]: pam_unix(sshd:session): session closed for user core Dec 13 14:13:24.250590 systemd-logind[1724]: Session 4 logged out. Waiting for processes to exit. Dec 13 14:13:24.251203 systemd[1]: sshd@3-172.31.24.189:22-139.178.89.65:54320.service: Deactivated successfully. Dec 13 14:13:24.252552 systemd[1]: session-4.scope: Deactivated successfully. Dec 13 14:13:24.254222 systemd-logind[1724]: Removed session 4. Dec 13 14:13:24.274319 systemd[1]: Started sshd@4-172.31.24.189:22-139.178.89.65:54334.service. Dec 13 14:13:24.446667 sshd[2256]: Accepted publickey for core from 139.178.89.65 port 54334 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:13:24.449737 sshd[2256]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:24.458431 systemd[1]: Started session-5.scope. Dec 13 14:13:24.460233 systemd-logind[1724]: New session 5 of user core. Dec 13 14:13:24.583167 sshd[2256]: pam_unix(sshd:session): session closed for user core Dec 13 14:13:24.588212 systemd[1]: session-5.scope: Deactivated successfully. Dec 13 14:13:24.589398 systemd[1]: sshd@4-172.31.24.189:22-139.178.89.65:54334.service: Deactivated successfully. Dec 13 14:13:24.591031 systemd-logind[1724]: Session 5 logged out. Waiting for processes to exit. Dec 13 14:13:24.593289 systemd-logind[1724]: Removed session 5. Dec 13 14:13:24.612233 systemd[1]: Started sshd@5-172.31.24.189:22-139.178.89.65:54336.service. Dec 13 14:13:24.785706 sshd[2262]: Accepted publickey for core from 139.178.89.65 port 54336 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:13:24.788889 sshd[2262]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:24.798054 systemd[1]: Started session-6.scope. Dec 13 14:13:24.800297 systemd-logind[1724]: New session 6 of user core. Dec 13 14:13:24.935660 sshd[2262]: pam_unix(sshd:session): session closed for user core Dec 13 14:13:24.940934 systemd-logind[1724]: Session 6 logged out. Waiting for processes to exit. Dec 13 14:13:24.941587 systemd[1]: sshd@5-172.31.24.189:22-139.178.89.65:54336.service: Deactivated successfully. Dec 13 14:13:24.942913 systemd[1]: session-6.scope: Deactivated successfully. Dec 13 14:13:24.944603 systemd-logind[1724]: Removed session 6. Dec 13 14:13:24.963788 systemd[1]: Started sshd@6-172.31.24.189:22-139.178.89.65:54344.service. Dec 13 14:13:25.133214 sshd[2268]: Accepted publickey for core from 139.178.89.65 port 54344 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:13:25.136390 sshd[2268]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:25.145565 systemd[1]: Started session-7.scope. Dec 13 14:13:25.146913 systemd-logind[1724]: New session 7 of user core. Dec 13 14:13:25.276051 sudo[2271]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Dec 13 14:13:25.277104 sudo[2271]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 13 14:13:25.293450 dbus-daemon[1718]: avc: received setenforce notice (enforcing=1) Dec 13 14:13:25.296338 sudo[2271]: pam_unix(sudo:session): session closed for user root Dec 13 14:13:25.321346 sshd[2268]: pam_unix(sshd:session): session closed for user core Dec 13 14:13:25.327254 systemd-logind[1724]: Session 7 logged out. Waiting for processes to exit. Dec 13 14:13:25.327730 systemd[1]: sshd@6-172.31.24.189:22-139.178.89.65:54344.service: Deactivated successfully. Dec 13 14:13:25.329213 systemd[1]: session-7.scope: Deactivated successfully. Dec 13 14:13:25.330667 systemd-logind[1724]: Removed session 7. Dec 13 14:13:25.349729 systemd[1]: Started sshd@7-172.31.24.189:22-139.178.89.65:54348.service. Dec 13 14:13:25.522243 sshd[2275]: Accepted publickey for core from 139.178.89.65 port 54348 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:13:25.525479 sshd[2275]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:25.534288 systemd[1]: Started session-8.scope. Dec 13 14:13:25.535965 systemd-logind[1724]: New session 8 of user core. Dec 13 14:13:25.643806 sudo[2279]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Dec 13 14:13:25.644355 sudo[2279]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 13 14:13:25.649367 sudo[2279]: pam_unix(sudo:session): session closed for user root Dec 13 14:13:25.658919 sudo[2278]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Dec 13 14:13:25.659475 sudo[2278]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 13 14:13:25.676325 systemd[1]: Stopping audit-rules.service... Dec 13 14:13:25.677000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Dec 13 14:13:25.680486 kernel: kauditd_printk_skb: 77 callbacks suppressed Dec 13 14:13:25.680562 kernel: audit: type=1305 audit(1734099205.677:171): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Dec 13 14:13:25.681081 auditctl[2282]: No rules Dec 13 14:13:25.682059 systemd[1]: audit-rules.service: Deactivated successfully. Dec 13 14:13:25.682465 systemd[1]: Stopped audit-rules.service. Dec 13 14:13:25.677000 audit[2282]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffffc26b630 a2=420 a3=0 items=0 ppid=1 pid=2282 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 13 14:13:25.695675 kernel: audit: type=1300 audit(1734099205.677:171): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffffc26b630 a2=420 a3=0 items=0 ppid=1 pid=2282 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 13 14:13:25.697288 systemd[1]: Starting audit-rules.service... Dec 13 14:13:25.677000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Dec 13 14:13:25.681000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.710275 kernel: audit: type=1327 audit(1734099205.677:171): proctitle=2F7362696E2F617564697463746C002D44 Dec 13 14:13:25.710441 kernel: audit: type=1131 audit(1734099205.681:172): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.730643 augenrules[2299]: No rules Dec 13 14:13:25.732366 systemd[1]: Finished audit-rules.service. Dec 13 14:13:25.731000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.734769 sudo[2278]: pam_unix(sudo:session): session closed for user root Dec 13 14:13:25.733000 audit[2278]: USER_END pid=2278 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.750137 kernel: audit: type=1130 audit(1734099205.731:173): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.750216 kernel: audit: type=1106 audit(1734099205.733:174): pid=2278 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.750259 kernel: audit: type=1104 audit(1734099205.733:175): pid=2278 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.733000 audit[2278]: CRED_DISP pid=2278 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.763357 sshd[2275]: pam_unix(sshd:session): session closed for user core Dec 13 14:13:25.764000 audit[2275]: USER_END pid=2275 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:25.769825 systemd[1]: sshd@7-172.31.24.189:22-139.178.89.65:54348.service: Deactivated successfully. Dec 13 14:13:25.770971 systemd[1]: session-8.scope: Deactivated successfully. Dec 13 14:13:25.772714 systemd-logind[1724]: Session 8 logged out. Waiting for processes to exit. Dec 13 14:13:25.774432 systemd-logind[1724]: Removed session 8. Dec 13 14:13:25.764000 audit[2275]: CRED_DISP pid=2275 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:25.784329 kernel: audit: type=1106 audit(1734099205.764:176): pid=2275 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:25.784404 kernel: audit: type=1104 audit(1734099205.764:177): pid=2275 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:25.784447 kernel: audit: type=1131 audit(1734099205.764:178): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-172.31.24.189:22-139.178.89.65:54348 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.764000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-172.31.24.189:22-139.178.89.65:54348 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.792000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-172.31.24.189:22-139.178.89.65:54350 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:25.793529 systemd[1]: Started sshd@8-172.31.24.189:22-139.178.89.65:54350.service. Dec 13 14:13:25.970000 audit[2305]: USER_ACCT pid=2305 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:25.972147 sshd[2305]: Accepted publickey for core from 139.178.89.65 port 54350 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:13:25.972000 audit[2305]: CRED_ACQ pid=2305 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:25.972000 audit[2305]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffcd3d0ab0 a2=3 a3=1 items=0 ppid=1 pid=2305 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=9 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 13 14:13:25.972000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Dec 13 14:13:25.974985 sshd[2305]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:25.983899 systemd[1]: Started session-9.scope. Dec 13 14:13:25.985071 systemd-logind[1724]: New session 9 of user core. Dec 13 14:13:25.992000 audit[2305]: USER_START pid=2305 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:25.995000 audit[2307]: CRED_ACQ pid=2307 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:26.111505 sshd[2305]: pam_unix(sshd:session): session closed for user core Dec 13 14:13:26.113000 audit[2305]: USER_END pid=2305 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:26.113000 audit[2305]: CRED_DISP pid=2305 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:26.117439 systemd[1]: sshd@8-172.31.24.189:22-139.178.89.65:54350.service: Deactivated successfully. Dec 13 14:13:26.116000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-172.31.24.189:22-139.178.89.65:54350 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:26.118693 systemd[1]: session-9.scope: Deactivated successfully. Dec 13 14:13:26.119847 systemd-logind[1724]: Session 9 logged out. Waiting for processes to exit. Dec 13 14:13:26.121398 systemd-logind[1724]: Removed session 9. Dec 13 14:13:26.137000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@9-172.31.24.189:22-139.178.89.65:54358 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:26.138759 systemd[1]: Started sshd@9-172.31.24.189:22-139.178.89.65:54358.service. Dec 13 14:13:26.312000 audit[2313]: USER_ACCT pid=2313 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:26.314058 sshd[2313]: Accepted publickey for core from 139.178.89.65 port 54358 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:13:26.314000 audit[2313]: CRED_ACQ pid=2313 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:26.314000 audit[2313]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffe5fb05a0 a2=3 a3=1 items=0 ppid=1 pid=2313 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=10 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 13 14:13:26.314000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Dec 13 14:13:26.316929 sshd[2313]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:13:26.324763 systemd-logind[1724]: New session 10 of user core. Dec 13 14:13:26.325762 systemd[1]: Started session-10.scope. Dec 13 14:13:26.333000 audit[2313]: USER_START pid=2313 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:26.336000 audit[2315]: CRED_ACQ pid=2315 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:26.665505 sshd[2313]: pam_unix(sshd:session): session closed for user core Dec 13 14:13:26.666000 audit[2313]: USER_END pid=2313 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:26.666000 audit[2313]: CRED_DISP pid=2313 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success' Dec 13 14:13:26.670786 systemd-logind[1724]: Session 10 logged out. Waiting for processes to exit. Dec 13 14:13:26.672015 systemd[1]: sshd@9-172.31.24.189:22-139.178.89.65:54358.service: Deactivated successfully. Dec 13 14:13:26.671000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@9-172.31.24.189:22-139.178.89.65:54358 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:26.673388 systemd[1]: session-10.scope: Deactivated successfully. Dec 13 14:13:26.674988 systemd-logind[1724]: Removed session 10. Dec 13 14:13:35.750572 amazon-ssm-agent[1877]: 2024-12-13 14:13:35 INFO [MessagingDeliveryService] [Association] No associations on boot. Requerying for associations after 30 seconds. Dec 13 14:13:39.504292 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Dec 13 14:13:39.504000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:39.506695 kernel: kauditd_printk_skb: 22 callbacks suppressed Dec 13 14:13:39.506745 kernel: audit: type=1131 audit(1734099219.504:197): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:13:39.542000 audit: BPF prog-id=37 op=UNLOAD Dec 13 14:13:39.542000 audit: BPF prog-id=36 op=UNLOAD Dec 13 14:13:39.546998 kernel: audit: type=1334 audit(1734099219.542:198): prog-id=37 op=UNLOAD Dec 13 14:13:39.547084 kernel: audit: type=1334 audit(1734099219.542:199): prog-id=36 op=UNLOAD Dec 13 14:13:39.547162 kernel: audit: type=1334 audit(1734099219.542:200): prog-id=35 op=UNLOAD Dec 13 14:13:39.542000 audit: BPF prog-id=35 op=UNLOAD Dec 13 14:13:54.076757 update_engine[1725]: I1213 14:13:54.076195 1725 update_attempter.cc:509] Updating boot flags... Dec 13 14:14:05.782519 amazon-ssm-agent[1877]: 2024-12-13 14:14:05 INFO [MessagingDeliveryService] [Association] Schedule manager refreshed with 0 associations, 0 new associations associated