Dec 13 14:14:10.980951 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Dec 13 14:14:10.980987 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:14:10.981009 kernel: efi: EFI v2.70 by EDK II Dec 13 14:14:10.981025 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b003a98 MEMRESERVE=0x7171cf98 Dec 13 14:14:10.981038 kernel: ACPI: Early table checksum verification disabled Dec 13 14:14:10.981052 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Dec 13 14:14:10.981068 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Dec 13 14:14:10.981082 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Dec 13 14:14:10.981096 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Dec 13 14:14:10.981109 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Dec 13 14:14:10.981127 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Dec 13 14:14:10.981141 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Dec 13 14:14:10.981155 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Dec 13 14:14:10.981169 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Dec 13 14:14:10.981197 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Dec 13 14:14:10.981221 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Dec 13 14:14:10.981236 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Dec 13 14:14:10.981251 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Dec 13 14:14:10.981266 kernel: printk: bootconsole [uart0] enabled Dec 13 14:14:10.981280 kernel: NUMA: Failed to initialise from firmware Dec 13 14:14:10.981295 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Dec 13 14:14:10.981310 kernel: NUMA: NODE_DATA [mem 0x4b5843900-0x4b5848fff] Dec 13 14:14:10.981324 kernel: Zone ranges: Dec 13 14:14:10.981339 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Dec 13 14:14:10.981353 kernel: DMA32 empty Dec 13 14:14:10.981367 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Dec 13 14:14:10.981385 kernel: Movable zone start for each node Dec 13 14:14:10.981400 kernel: Early memory node ranges Dec 13 14:14:10.981414 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Dec 13 14:14:10.981428 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Dec 13 14:14:10.981443 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Dec 13 14:14:10.981457 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Dec 13 14:14:10.981471 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Dec 13 14:14:10.981486 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Dec 13 14:14:10.981500 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Dec 13 14:14:10.981514 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Dec 13 14:14:10.981529 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Dec 13 14:14:10.981543 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Dec 13 14:14:10.981562 kernel: psci: probing for conduit method from ACPI. Dec 13 14:14:10.981577 kernel: psci: PSCIv1.0 detected in firmware. Dec 13 14:14:10.981598 kernel: psci: Using standard PSCI v0.2 function IDs Dec 13 14:14:10.981614 kernel: psci: Trusted OS migration not required Dec 13 14:14:10.981629 kernel: psci: SMC Calling Convention v1.1 Dec 13 14:14:10.981648 kernel: ACPI: SRAT not present Dec 13 14:14:10.981664 kernel: percpu: Embedded 30 pages/cpu s83032 r8192 d31656 u122880 Dec 13 14:14:10.981679 kernel: pcpu-alloc: s83032 r8192 d31656 u122880 alloc=30*4096 Dec 13 14:14:10.981695 kernel: pcpu-alloc: [0] 0 [0] 1 Dec 13 14:14:10.981710 kernel: Detected PIPT I-cache on CPU0 Dec 13 14:14:10.981725 kernel: CPU features: detected: GIC system register CPU interface Dec 13 14:14:10.981740 kernel: CPU features: detected: Spectre-v2 Dec 13 14:14:10.981755 kernel: CPU features: detected: Spectre-v3a Dec 13 14:14:10.981770 kernel: CPU features: detected: Spectre-BHB Dec 13 14:14:10.981877 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 13 14:14:10.981897 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 13 14:14:10.981918 kernel: CPU features: detected: ARM erratum 1742098 Dec 13 14:14:10.981934 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Dec 13 14:14:10.981949 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Dec 13 14:14:10.981964 kernel: Policy zone: Normal Dec 13 14:14:10.981982 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:14:10.981999 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Dec 13 14:14:10.982014 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 13 14:14:10.982030 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 13 14:14:10.982045 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 13 14:14:10.982060 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Dec 13 14:14:10.982082 kernel: Memory: 3824524K/4030464K available (9792K kernel code, 2092K rwdata, 7576K rodata, 36416K init, 777K bss, 205940K reserved, 0K cma-reserved) Dec 13 14:14:10.982098 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Dec 13 14:14:10.982113 kernel: trace event string verifier disabled Dec 13 14:14:10.982128 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 13 14:14:10.982144 kernel: rcu: RCU event tracing is enabled. Dec 13 14:14:10.982160 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Dec 13 14:14:10.982175 kernel: Trampoline variant of Tasks RCU enabled. Dec 13 14:14:10.982191 kernel: Tracing variant of Tasks RCU enabled. Dec 13 14:14:10.982206 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 13 14:14:10.982222 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Dec 13 14:14:10.982237 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 13 14:14:10.982252 kernel: GICv3: 96 SPIs implemented Dec 13 14:14:10.982271 kernel: GICv3: 0 Extended SPIs implemented Dec 13 14:14:10.982286 kernel: GICv3: Distributor has no Range Selector support Dec 13 14:14:10.982301 kernel: Root IRQ handler: gic_handle_irq Dec 13 14:14:10.982316 kernel: GICv3: 16 PPIs implemented Dec 13 14:14:10.982331 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Dec 13 14:14:10.982346 kernel: ACPI: SRAT not present Dec 13 14:14:10.982361 kernel: ITS [mem 0x10080000-0x1009ffff] Dec 13 14:14:10.982376 kernel: ITS@0x0000000010080000: allocated 8192 Devices @400090000 (indirect, esz 8, psz 64K, shr 1) Dec 13 14:14:10.982392 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000a0000 (flat, esz 8, psz 64K, shr 1) Dec 13 14:14:10.982407 kernel: GICv3: using LPI property table @0x00000004000b0000 Dec 13 14:14:10.982423 kernel: ITS: Using hypervisor restricted LPI range [128] Dec 13 14:14:10.982442 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000d0000 Dec 13 14:14:10.982457 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Dec 13 14:14:10.982472 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Dec 13 14:14:10.982488 kernel: sched_clock: 56 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Dec 13 14:14:10.982504 kernel: Console: colour dummy device 80x25 Dec 13 14:14:10.982520 kernel: printk: console [tty1] enabled Dec 13 14:14:10.982535 kernel: ACPI: Core revision 20210730 Dec 13 14:14:10.982551 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Dec 13 14:14:10.982567 kernel: pid_max: default: 32768 minimum: 301 Dec 13 14:14:10.982582 kernel: LSM: Security Framework initializing Dec 13 14:14:10.982601 kernel: SELinux: Initializing. Dec 13 14:14:10.982617 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 13 14:14:10.982633 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 13 14:14:10.982649 kernel: rcu: Hierarchical SRCU implementation. Dec 13 14:14:10.982664 kernel: Platform MSI: ITS@0x10080000 domain created Dec 13 14:14:10.982679 kernel: PCI/MSI: ITS@0x10080000 domain created Dec 13 14:14:10.982695 kernel: Remapping and enabling EFI services. Dec 13 14:14:10.982710 kernel: smp: Bringing up secondary CPUs ... Dec 13 14:14:10.982726 kernel: Detected PIPT I-cache on CPU1 Dec 13 14:14:10.982745 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Dec 13 14:14:10.982761 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000e0000 Dec 13 14:14:10.982777 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Dec 13 14:14:10.982823 kernel: smp: Brought up 1 node, 2 CPUs Dec 13 14:14:10.982840 kernel: SMP: Total of 2 processors activated. Dec 13 14:14:10.982856 kernel: CPU features: detected: 32-bit EL0 Support Dec 13 14:14:10.982871 kernel: CPU features: detected: 32-bit EL1 Support Dec 13 14:14:10.982886 kernel: CPU features: detected: CRC32 instructions Dec 13 14:14:10.982901 kernel: CPU: All CPU(s) started at EL1 Dec 13 14:14:10.982922 kernel: alternatives: patching kernel code Dec 13 14:14:10.982937 kernel: devtmpfs: initialized Dec 13 14:14:10.982953 kernel: KASLR disabled due to lack of seed Dec 13 14:14:10.982979 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 13 14:14:10.982999 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Dec 13 14:14:10.983015 kernel: pinctrl core: initialized pinctrl subsystem Dec 13 14:14:10.983031 kernel: SMBIOS 3.0.0 present. Dec 13 14:14:10.983046 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Dec 13 14:14:10.983063 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 13 14:14:10.983079 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 13 14:14:10.983095 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 13 14:14:10.983112 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 13 14:14:10.983132 kernel: audit: initializing netlink subsys (disabled) Dec 13 14:14:10.983149 kernel: audit: type=2000 audit(0.258:1): state=initialized audit_enabled=0 res=1 Dec 13 14:14:10.983165 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 13 14:14:10.983181 kernel: cpuidle: using governor menu Dec 13 14:14:10.983197 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 13 14:14:10.983217 kernel: ASID allocator initialised with 32768 entries Dec 13 14:14:10.983233 kernel: ACPI: bus type PCI registered Dec 13 14:14:10.983249 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 13 14:14:10.983265 kernel: Serial: AMBA PL011 UART driver Dec 13 14:14:10.983281 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Dec 13 14:14:10.983297 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Dec 13 14:14:10.983313 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Dec 13 14:14:10.983329 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Dec 13 14:14:10.983345 kernel: cryptd: max_cpu_qlen set to 1000 Dec 13 14:14:10.983365 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Dec 13 14:14:10.983381 kernel: ACPI: Added _OSI(Module Device) Dec 13 14:14:10.983397 kernel: ACPI: Added _OSI(Processor Device) Dec 13 14:14:10.983413 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Dec 13 14:14:10.983429 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 13 14:14:10.983445 kernel: ACPI: Added _OSI(Linux-Dell-Video) Dec 13 14:14:10.983461 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Dec 13 14:14:10.983477 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Dec 13 14:14:10.983493 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 13 14:14:10.983512 kernel: ACPI: Interpreter enabled Dec 13 14:14:10.983529 kernel: ACPI: Using GIC for interrupt routing Dec 13 14:14:10.983544 kernel: ACPI: MCFG table detected, 1 entries Dec 13 14:14:10.983560 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Dec 13 14:14:10.985924 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 13 14:14:10.986158 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 13 14:14:10.986349 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 13 14:14:10.986548 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Dec 13 14:14:10.988316 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Dec 13 14:14:10.988352 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Dec 13 14:14:10.988371 kernel: acpiphp: Slot [1] registered Dec 13 14:14:10.988388 kernel: acpiphp: Slot [2] registered Dec 13 14:14:10.988405 kernel: acpiphp: Slot [3] registered Dec 13 14:14:10.988422 kernel: acpiphp: Slot [4] registered Dec 13 14:14:10.988438 kernel: acpiphp: Slot [5] registered Dec 13 14:14:10.988455 kernel: acpiphp: Slot [6] registered Dec 13 14:14:10.988478 kernel: acpiphp: Slot [7] registered Dec 13 14:14:10.988495 kernel: acpiphp: Slot [8] registered Dec 13 14:14:10.988512 kernel: acpiphp: Slot [9] registered Dec 13 14:14:10.988528 kernel: acpiphp: Slot [10] registered Dec 13 14:14:10.988545 kernel: acpiphp: Slot [11] registered Dec 13 14:14:10.988561 kernel: acpiphp: Slot [12] registered Dec 13 14:14:10.988577 kernel: acpiphp: Slot [13] registered Dec 13 14:14:10.988593 kernel: acpiphp: Slot [14] registered Dec 13 14:14:10.988610 kernel: acpiphp: Slot [15] registered Dec 13 14:14:10.988626 kernel: acpiphp: Slot [16] registered Dec 13 14:14:10.988647 kernel: acpiphp: Slot [17] registered Dec 13 14:14:10.988663 kernel: acpiphp: Slot [18] registered Dec 13 14:14:10.988679 kernel: acpiphp: Slot [19] registered Dec 13 14:14:10.988695 kernel: acpiphp: Slot [20] registered Dec 13 14:14:10.988726 kernel: acpiphp: Slot [21] registered Dec 13 14:14:10.988746 kernel: acpiphp: Slot [22] registered Dec 13 14:14:10.988762 kernel: acpiphp: Slot [23] registered Dec 13 14:14:10.988778 kernel: acpiphp: Slot [24] registered Dec 13 14:14:10.988830 kernel: acpiphp: Slot [25] registered Dec 13 14:14:10.988855 kernel: acpiphp: Slot [26] registered Dec 13 14:14:10.988872 kernel: acpiphp: Slot [27] registered Dec 13 14:14:10.988889 kernel: acpiphp: Slot [28] registered Dec 13 14:14:10.988905 kernel: acpiphp: Slot [29] registered Dec 13 14:14:10.988922 kernel: acpiphp: Slot [30] registered Dec 13 14:14:10.988938 kernel: acpiphp: Slot [31] registered Dec 13 14:14:10.988954 kernel: PCI host bridge to bus 0000:00 Dec 13 14:14:10.989169 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Dec 13 14:14:11.004137 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 13 14:14:11.004326 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Dec 13 14:14:11.004502 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Dec 13 14:14:11.004723 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Dec 13 14:14:11.004992 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Dec 13 14:14:11.005192 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Dec 13 14:14:11.005440 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Dec 13 14:14:11.005644 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Dec 13 14:14:11.005879 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Dec 13 14:14:11.006106 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Dec 13 14:14:11.006305 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Dec 13 14:14:11.006503 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Dec 13 14:14:11.006698 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Dec 13 14:14:11.006971 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Dec 13 14:14:11.007197 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Dec 13 14:14:11.007391 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Dec 13 14:14:11.007585 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Dec 13 14:14:11.008872 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Dec 13 14:14:11.009100 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Dec 13 14:14:11.009278 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Dec 13 14:14:11.009450 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 13 14:14:11.009630 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Dec 13 14:14:11.009653 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Dec 13 14:14:11.009670 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Dec 13 14:14:11.009686 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Dec 13 14:14:11.009702 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Dec 13 14:14:11.009719 kernel: iommu: Default domain type: Translated Dec 13 14:14:11.009735 kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 13 14:14:11.009751 kernel: vgaarb: loaded Dec 13 14:14:11.009767 kernel: pps_core: LinuxPPS API ver. 1 registered Dec 13 14:14:11.009814 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Dec 13 14:14:11.011827 kernel: PTP clock support registered Dec 13 14:14:11.011851 kernel: Registered efivars operations Dec 13 14:14:11.011868 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 13 14:14:11.011885 kernel: VFS: Disk quotas dquot_6.6.0 Dec 13 14:14:11.011902 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 13 14:14:11.011918 kernel: pnp: PnP ACPI init Dec 13 14:14:11.012132 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Dec 13 14:14:11.012162 kernel: pnp: PnP ACPI: found 1 devices Dec 13 14:14:11.012180 kernel: NET: Registered PF_INET protocol family Dec 13 14:14:11.012196 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 13 14:14:11.012213 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 13 14:14:11.012229 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 13 14:14:11.012246 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 13 14:14:11.012262 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Dec 13 14:14:11.012278 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 13 14:14:11.012295 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 13 14:14:11.012315 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 13 14:14:11.012331 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 13 14:14:11.012347 kernel: PCI: CLS 0 bytes, default 64 Dec 13 14:14:11.012364 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Dec 13 14:14:11.012379 kernel: kvm [1]: HYP mode not available Dec 13 14:14:11.012396 kernel: Initialise system trusted keyrings Dec 13 14:14:11.012412 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 13 14:14:11.012428 kernel: Key type asymmetric registered Dec 13 14:14:11.012445 kernel: Asymmetric key parser 'x509' registered Dec 13 14:14:11.012465 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Dec 13 14:14:11.012481 kernel: io scheduler mq-deadline registered Dec 13 14:14:11.012498 kernel: io scheduler kyber registered Dec 13 14:14:11.012514 kernel: io scheduler bfq registered Dec 13 14:14:11.012710 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Dec 13 14:14:11.012735 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 13 14:14:11.012751 kernel: ACPI: button: Power Button [PWRB] Dec 13 14:14:11.012826 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Dec 13 14:14:11.019867 kernel: ACPI: button: Sleep Button [SLPB] Dec 13 14:14:11.019892 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 13 14:14:11.019911 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Dec 13 14:14:11.020170 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Dec 13 14:14:11.020195 kernel: printk: console [ttyS0] disabled Dec 13 14:14:11.020213 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Dec 13 14:14:11.020230 kernel: printk: console [ttyS0] enabled Dec 13 14:14:11.020246 kernel: printk: bootconsole [uart0] disabled Dec 13 14:14:11.020263 kernel: thunder_xcv, ver 1.0 Dec 13 14:14:11.020284 kernel: thunder_bgx, ver 1.0 Dec 13 14:14:11.020300 kernel: nicpf, ver 1.0 Dec 13 14:14:11.020316 kernel: nicvf, ver 1.0 Dec 13 14:14:11.020518 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 13 14:14:11.020702 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-12-13T14:14:10 UTC (1734099250) Dec 13 14:14:11.020726 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 13 14:14:11.020743 kernel: NET: Registered PF_INET6 protocol family Dec 13 14:14:11.020759 kernel: Segment Routing with IPv6 Dec 13 14:14:11.020795 kernel: In-situ OAM (IOAM) with IPv6 Dec 13 14:14:11.020831 kernel: NET: Registered PF_PACKET protocol family Dec 13 14:14:11.020874 kernel: Key type dns_resolver registered Dec 13 14:14:11.020895 kernel: registered taskstats version 1 Dec 13 14:14:11.020912 kernel: Loading compiled-in X.509 certificates Dec 13 14:14:11.020930 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.173-flatcar: e011ba9949ade5a6d03f7a5e28171f7f59e70f8a' Dec 13 14:14:11.020947 kernel: Key type .fscrypt registered Dec 13 14:14:11.020963 kernel: Key type fscrypt-provisioning registered Dec 13 14:14:11.020979 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 13 14:14:11.020995 kernel: ima: Allocated hash algorithm: sha1 Dec 13 14:14:11.021017 kernel: ima: No architecture policies found Dec 13 14:14:11.021034 kernel: clk: Disabling unused clocks Dec 13 14:14:11.021050 kernel: Freeing unused kernel memory: 36416K Dec 13 14:14:11.021066 kernel: Run /init as init process Dec 13 14:14:11.021082 kernel: with arguments: Dec 13 14:14:11.021098 kernel: /init Dec 13 14:14:11.021114 kernel: with environment: Dec 13 14:14:11.021129 kernel: HOME=/ Dec 13 14:14:11.021145 kernel: TERM=linux Dec 13 14:14:11.021165 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Dec 13 14:14:11.021186 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:14:11.021208 systemd[1]: Detected virtualization amazon. Dec 13 14:14:11.021226 systemd[1]: Detected architecture arm64. Dec 13 14:14:11.021244 systemd[1]: Running in initrd. Dec 13 14:14:11.021261 systemd[1]: No hostname configured, using default hostname. Dec 13 14:14:11.021278 systemd[1]: Hostname set to . Dec 13 14:14:11.021300 systemd[1]: Initializing machine ID from VM UUID. Dec 13 14:14:11.021318 systemd[1]: Queued start job for default target initrd.target. Dec 13 14:14:11.021335 systemd[1]: Started systemd-ask-password-console.path. Dec 13 14:14:11.021353 systemd[1]: Reached target cryptsetup.target. Dec 13 14:14:11.021370 systemd[1]: Reached target paths.target. Dec 13 14:14:11.021387 systemd[1]: Reached target slices.target. Dec 13 14:14:11.021405 systemd[1]: Reached target swap.target. Dec 13 14:14:11.021422 systemd[1]: Reached target timers.target. Dec 13 14:14:11.021444 systemd[1]: Listening on iscsid.socket. Dec 13 14:14:11.021462 systemd[1]: Listening on iscsiuio.socket. Dec 13 14:14:11.021479 systemd[1]: Listening on systemd-journald-audit.socket. Dec 13 14:14:11.021497 systemd[1]: Listening on systemd-journald-dev-log.socket. Dec 13 14:14:11.021514 systemd[1]: Listening on systemd-journald.socket. Dec 13 14:14:11.021532 systemd[1]: Listening on systemd-networkd.socket. Dec 13 14:14:11.021550 systemd[1]: Listening on systemd-udevd-control.socket. Dec 13 14:14:11.021567 systemd[1]: Listening on systemd-udevd-kernel.socket. Dec 13 14:14:11.021589 systemd[1]: Reached target sockets.target. Dec 13 14:14:11.021607 systemd[1]: Starting kmod-static-nodes.service... Dec 13 14:14:11.021624 systemd[1]: Finished network-cleanup.service. Dec 13 14:14:11.021642 systemd[1]: Starting systemd-fsck-usr.service... Dec 13 14:14:11.021659 systemd[1]: Starting systemd-journald.service... Dec 13 14:14:11.021693 systemd[1]: Starting systemd-modules-load.service... Dec 13 14:14:11.021713 systemd[1]: Starting systemd-resolved.service... Dec 13 14:14:11.021731 systemd[1]: Starting systemd-vconsole-setup.service... Dec 13 14:14:11.021748 systemd[1]: Finished kmod-static-nodes.service. Dec 13 14:14:11.021771 systemd[1]: Finished systemd-fsck-usr.service. Dec 13 14:14:11.021818 kernel: audit: type=1130 audit(1734099250.969:2): 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:14:11.021838 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Dec 13 14:14:11.021856 systemd[1]: Finished systemd-vconsole-setup.service. Dec 13 14:14:11.021875 kernel: audit: type=1130 audit(1734099250.996:3): 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:14:11.021892 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Dec 13 14:14:11.021910 kernel: audit: type=1130 audit(1734099251.011:4): 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:14:11.021932 systemd[1]: Starting dracut-cmdline-ask.service... Dec 13 14:14:11.021953 systemd-journald[309]: Journal started Dec 13 14:14:11.022038 systemd-journald[309]: Runtime Journal (/run/log/journal/ec24a300f95b3ccf34627bc389dafce3) is 8.0M, max 75.4M, 67.4M free. Dec 13 14:14:10.969000 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:14:10.996000 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:14:11.011000 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:14:10.960390 systemd-modules-load[310]: Inserted module 'overlay' Dec 13 14:14:11.030848 systemd[1]: Started systemd-journald.service. Dec 13 14:14:11.036828 kernel: audit: type=1130 audit(1734099251.034: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:14:11.034000 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:14:11.051328 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:14:11.064543 systemd-modules-load[310]: Inserted module 'br_netfilter' Dec 13 14:14:11.066234 kernel: Bridge firewalling registered Dec 13 14:14:11.065634 systemd-resolved[311]: Positive Trust Anchors: Dec 13 14:14:11.065649 systemd-resolved[311]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 13 14:14:11.065708 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:14:11.100405 systemd[1]: Finished dracut-cmdline-ask.service. Dec 13 14:14:11.100000 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:14:11.112210 systemd[1]: Starting dracut-cmdline.service... Dec 13 14:14:11.120942 kernel: audit: type=1130 audit(1734099251.100:6): 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:14:11.121051 kernel: SCSI subsystem initialized Dec 13 14:14:11.139533 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Dec 13 14:14:11.139627 kernel: device-mapper: uevent: version 1.0.3 Dec 13 14:14:11.142816 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Dec 13 14:14:11.150098 systemd-modules-load[310]: Inserted module 'dm_multipath' Dec 13 14:14:11.153034 dracut-cmdline[327]: dracut-dracut-053 Dec 13 14:14:11.154000 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:14:11.155017 systemd[1]: Finished systemd-modules-load.service. Dec 13 14:14:11.166282 systemd[1]: Starting systemd-sysctl.service... Dec 13 14:14:11.169670 kernel: audit: type=1130 audit(1734099251.154:7): 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:14:11.180072 dracut-cmdline[327]: 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:14:11.205229 systemd[1]: Finished systemd-sysctl.service. Dec 13 14:14:11.205000 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:14:11.216871 kernel: audit: type=1130 audit(1734099251.205:8): 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:14:11.324844 kernel: Loading iSCSI transport class v2.0-870. Dec 13 14:14:11.348855 kernel: iscsi: registered transport (tcp) Dec 13 14:14:11.377308 kernel: iscsi: registered transport (qla4xxx) Dec 13 14:14:11.377405 kernel: QLogic iSCSI HBA Driver Dec 13 14:14:11.563680 systemd-resolved[311]: Defaulting to hostname 'linux'. Dec 13 14:14:11.565513 kernel: random: crng init done Dec 13 14:14:11.567461 systemd[1]: Started systemd-resolved.service. Dec 13 14:14:11.579158 kernel: audit: type=1130 audit(1734099251.568:9): 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:14:11.568000 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:14:11.569286 systemd[1]: Reached target nss-lookup.target. Dec 13 14:14:11.599558 systemd[1]: Finished dracut-cmdline.service. Dec 13 14:14:11.601000 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:14:11.604234 systemd[1]: Starting dracut-pre-udev.service... Dec 13 14:14:11.615021 kernel: audit: type=1130 audit(1734099251.601:10): 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:14:11.673846 kernel: raid6: neonx8 gen() 6309 MB/s Dec 13 14:14:11.691834 kernel: raid6: neonx8 xor() 4724 MB/s Dec 13 14:14:11.709830 kernel: raid6: neonx4 gen() 6379 MB/s Dec 13 14:14:11.727844 kernel: raid6: neonx4 xor() 4882 MB/s Dec 13 14:14:11.745834 kernel: raid6: neonx2 gen() 5636 MB/s Dec 13 14:14:11.763826 kernel: raid6: neonx2 xor() 4536 MB/s Dec 13 14:14:11.781813 kernel: raid6: neonx1 gen() 4435 MB/s Dec 13 14:14:11.799814 kernel: raid6: neonx1 xor() 3671 MB/s Dec 13 14:14:11.817815 kernel: raid6: int64x8 gen() 3392 MB/s Dec 13 14:14:11.835814 kernel: raid6: int64x8 xor() 2079 MB/s Dec 13 14:14:11.853815 kernel: raid6: int64x4 gen() 3780 MB/s Dec 13 14:14:11.871815 kernel: raid6: int64x4 xor() 2187 MB/s Dec 13 14:14:11.889819 kernel: raid6: int64x2 gen() 3556 MB/s Dec 13 14:14:11.907832 kernel: raid6: int64x2 xor() 1940 MB/s Dec 13 14:14:11.925829 kernel: raid6: int64x1 gen() 2743 MB/s Dec 13 14:14:11.945084 kernel: raid6: int64x1 xor() 1441 MB/s Dec 13 14:14:11.945148 kernel: raid6: using algorithm neonx4 gen() 6379 MB/s Dec 13 14:14:11.945173 kernel: raid6: .... xor() 4882 MB/s, rmw enabled Dec 13 14:14:11.946740 kernel: raid6: using neon recovery algorithm Dec 13 14:14:11.968164 kernel: xor: measuring software checksum speed Dec 13 14:14:11.968235 kernel: 8regs : 9338 MB/sec Dec 13 14:14:11.969970 kernel: 32regs : 11117 MB/sec Dec 13 14:14:11.971802 kernel: arm64_neon : 9580 MB/sec Dec 13 14:14:11.971847 kernel: xor: using function: 32regs (11117 MB/sec) Dec 13 14:14:12.068876 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Dec 13 14:14:12.090072 systemd[1]: Finished dracut-pre-udev.service. Dec 13 14:14:12.091000 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:14:12.092000 audit: BPF prog-id=7 op=LOAD Dec 13 14:14:12.092000 audit: BPF prog-id=8 op=LOAD Dec 13 14:14:12.094958 systemd[1]: Starting systemd-udevd.service... Dec 13 14:14:12.125059 systemd-udevd[508]: Using default interface naming scheme 'v252'. Dec 13 14:14:12.136391 systemd[1]: Started systemd-udevd.service. Dec 13 14:14:12.138000 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:14:12.144050 systemd[1]: Starting dracut-pre-trigger.service... Dec 13 14:14:12.173923 dracut-pre-trigger[516]: rd.md=0: removing MD RAID activation Dec 13 14:14:12.234012 systemd[1]: Finished dracut-pre-trigger.service. Dec 13 14:14:12.235000 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:14:12.238344 systemd[1]: Starting systemd-udev-trigger.service... Dec 13 14:14:12.341319 systemd[1]: Finished systemd-udev-trigger.service. Dec 13 14:14:12.343000 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:14:12.489643 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Dec 13 14:14:12.489721 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Dec 13 14:14:12.503887 kernel: ena 0000:00:05.0: ENA device version: 0.10 Dec 13 14:14:12.504133 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Dec 13 14:14:12.504343 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Dec 13 14:14:12.504381 kernel: nvme nvme0: pci function 0000:00:04.0 Dec 13 14:14:12.504628 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:a8:df:36:80:bd Dec 13 14:14:12.513828 kernel: nvme nvme0: 2/0/0 default/read/poll queues Dec 13 14:14:12.520574 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Dec 13 14:14:12.520628 kernel: GPT:9289727 != 16777215 Dec 13 14:14:12.520651 kernel: GPT:Alternate GPT header not at the end of the disk. Dec 13 14:14:12.522559 kernel: GPT:9289727 != 16777215 Dec 13 14:14:12.523752 kernel: GPT: Use GNU Parted to correct GPT errors. Dec 13 14:14:12.526882 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Dec 13 14:14:12.531406 (udev-worker)[565]: Network interface NamePolicy= disabled on kernel command line. Dec 13 14:14:12.593827 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by (udev-worker) (560) Dec 13 14:14:12.649247 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Dec 13 14:14:12.686688 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Dec 13 14:14:12.704029 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Dec 13 14:14:12.709074 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Dec 13 14:14:12.723650 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Dec 13 14:14:12.747219 systemd[1]: Starting disk-uuid.service... Dec 13 14:14:12.759070 disk-uuid[667]: Primary Header is updated. Dec 13 14:14:12.759070 disk-uuid[667]: Secondary Entries is updated. Dec 13 14:14:12.759070 disk-uuid[667]: Secondary Header is updated. Dec 13 14:14:12.767864 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Dec 13 14:14:12.776832 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Dec 13 14:14:13.783817 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Dec 13 14:14:13.784459 disk-uuid[668]: The operation has completed successfully. Dec 13 14:14:13.966755 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 13 14:14:13.967342 systemd[1]: Finished disk-uuid.service. Dec 13 14:14:13.969000 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:14:13.970000 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:14:13.983528 systemd[1]: Starting verity-setup.service... Dec 13 14:14:14.021380 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Dec 13 14:14:14.121275 systemd[1]: Found device dev-mapper-usr.device. Dec 13 14:14:14.126856 systemd[1]: Mounting sysusr-usr.mount... Dec 13 14:14:14.136540 systemd[1]: Finished verity-setup.service. Dec 13 14:14:14.138000 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:14:14.223925 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Dec 13 14:14:14.225158 systemd[1]: Mounted sysusr-usr.mount. Dec 13 14:14:14.228188 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Dec 13 14:14:14.231991 systemd[1]: Starting ignition-setup.service... Dec 13 14:14:14.244412 systemd[1]: Starting parse-ip-for-networkd.service... Dec 13 14:14:14.264752 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Dec 13 14:14:14.264853 kernel: BTRFS info (device nvme0n1p6): using free space tree Dec 13 14:14:14.264880 kernel: BTRFS info (device nvme0n1p6): has skinny extents Dec 13 14:14:14.280837 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Dec 13 14:14:14.300878 systemd[1]: mnt-oem.mount: Deactivated successfully. Dec 13 14:14:14.317544 systemd[1]: Finished ignition-setup.service. Dec 13 14:14:14.319000 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:14:14.321747 systemd[1]: Starting ignition-fetch-offline.service... Dec 13 14:14:14.396554 systemd[1]: Finished parse-ip-for-networkd.service. Dec 13 14:14:14.398000 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:14:14.399000 audit: BPF prog-id=9 op=LOAD Dec 13 14:14:14.402048 systemd[1]: Starting systemd-networkd.service... Dec 13 14:14:14.450139 systemd-networkd[1097]: lo: Link UP Dec 13 14:14:14.450161 systemd-networkd[1097]: lo: Gained carrier Dec 13 14:14:14.453888 systemd-networkd[1097]: Enumeration completed Dec 13 14:14:14.455000 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:14:14.454374 systemd-networkd[1097]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 13 14:14:14.454544 systemd[1]: Started systemd-networkd.service. Dec 13 14:14:14.456322 systemd[1]: Reached target network.target. Dec 13 14:14:14.462858 systemd[1]: Starting iscsiuio.service... Dec 13 14:14:14.477882 systemd-networkd[1097]: eth0: Link UP Dec 13 14:14:14.477896 systemd-networkd[1097]: eth0: Gained carrier Dec 13 14:14:14.480357 systemd[1]: Started iscsiuio.service. Dec 13 14:14:14.482000 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:14:14.497201 systemd[1]: Starting iscsid.service... Dec 13 14:14:14.500955 systemd-networkd[1097]: eth0: DHCPv4 address 172.31.18.236/20, gateway 172.31.16.1 acquired from 172.31.16.1 Dec 13 14:14:14.508168 iscsid[1102]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Dec 13 14:14:14.508168 iscsid[1102]: 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:14:14.508168 iscsid[1102]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Dec 13 14:14:14.508168 iscsid[1102]: If using hardware iscsi like qla4xxx this message can be ignored. Dec 13 14:14:14.523859 iscsid[1102]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Dec 13 14:14:14.523859 iscsid[1102]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Dec 13 14:14:14.531884 systemd[1]: Started iscsid.service. Dec 13 14:14:14.530000 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:14:14.545831 systemd[1]: Starting dracut-initqueue.service... Dec 13 14:14:14.568582 systemd[1]: Finished dracut-initqueue.service. Dec 13 14:14:14.571737 systemd[1]: Reached target remote-fs-pre.target. Dec 13 14:14:14.570000 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:14:14.575209 systemd[1]: Reached target remote-cryptsetup.target. Dec 13 14:14:14.578475 systemd[1]: Reached target remote-fs.target. Dec 13 14:14:14.582865 systemd[1]: Starting dracut-pre-mount.service... Dec 13 14:14:14.604687 systemd[1]: Finished dracut-pre-mount.service. Dec 13 14:14:14.605000 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:14:15.189026 ignition[1031]: Ignition 2.14.0 Dec 13 14:14:15.189704 ignition[1031]: Stage: fetch-offline Dec 13 14:14:15.190194 ignition[1031]: reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:14:15.190258 ignition[1031]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:14:15.210043 ignition[1031]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:14:15.212402 ignition[1031]: Ignition finished successfully Dec 13 14:14:15.215459 systemd[1]: Finished ignition-fetch-offline.service. Dec 13 14:14:15.227769 kernel: kauditd_printk_skb: 17 callbacks suppressed Dec 13 14:14:15.227823 kernel: audit: type=1130 audit(1734099255.216:28): 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:14:15.216000 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:14:15.228613 systemd[1]: Starting ignition-fetch.service... Dec 13 14:14:15.243262 ignition[1121]: Ignition 2.14.0 Dec 13 14:14:15.243291 ignition[1121]: Stage: fetch Dec 13 14:14:15.243591 ignition[1121]: reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:14:15.243649 ignition[1121]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:14:15.257543 ignition[1121]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:14:15.259658 ignition[1121]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:14:15.283235 ignition[1121]: INFO : PUT result: OK Dec 13 14:14:15.286708 ignition[1121]: DEBUG : parsed url from cmdline: "" Dec 13 14:14:15.288405 ignition[1121]: INFO : no config URL provided Dec 13 14:14:15.289951 ignition[1121]: INFO : reading system config file "/usr/lib/ignition/user.ign" Dec 13 14:14:15.292212 ignition[1121]: INFO : no config at "/usr/lib/ignition/user.ign" Dec 13 14:14:15.292212 ignition[1121]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:14:15.308972 ignition[1121]: INFO : PUT result: OK Dec 13 14:14:15.308972 ignition[1121]: INFO : GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Dec 13 14:14:15.312649 ignition[1121]: INFO : GET result: Not Found Dec 13 14:14:15.312649 ignition[1121]: DEBUG : parsing config with SHA512: cf83e1357eefb8bdf1542850d66d8007d620e4050b5715dc83f4a921d36ce9ce47d0d13c5d85f2b0ff8318d2877eec2f63b931bd47417a81a538327af927da3e Dec 13 14:14:15.310877 ignition[1121]: not a config (empty): provider config was empty, continuing with empty cache config Dec 13 14:14:15.315705 unknown[1121]: fetched base config from "system" Dec 13 14:14:15.325000 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:14:15.316442 ignition[1121]: fetch: fetch complete Dec 13 14:14:15.336121 kernel: audit: type=1130 audit(1734099255.325:29): 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:14:15.315722 unknown[1121]: fetched base config from "system" Dec 13 14:14:15.316455 ignition[1121]: fetch: fetch passed Dec 13 14:14:15.322716 systemd[1]: Finished ignition-fetch.service. Dec 13 14:14:15.316555 ignition[1121]: Ignition finished successfully Dec 13 14:14:15.342383 systemd[1]: Starting ignition-kargs.service... Dec 13 14:14:15.359196 ignition[1127]: Ignition 2.14.0 Dec 13 14:14:15.359222 ignition[1127]: Stage: kargs Dec 13 14:14:15.359516 ignition[1127]: reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:14:15.359574 ignition[1127]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:14:15.373581 ignition[1127]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:14:15.375801 ignition[1127]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:14:15.378678 ignition[1127]: INFO : PUT result: OK Dec 13 14:14:15.382715 ignition[1127]: kargs: kargs passed Dec 13 14:14:15.382851 ignition[1127]: Ignition finished successfully Dec 13 14:14:15.387208 systemd[1]: Finished ignition-kargs.service. Dec 13 14:14:15.388000 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:14:15.391483 systemd[1]: Starting ignition-disks.service... Dec 13 14:14:15.399525 kernel: audit: type=1130 audit(1734099255.388:30): 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:14:15.406751 ignition[1133]: Ignition 2.14.0 Dec 13 14:14:15.406800 ignition[1133]: Stage: disks Dec 13 14:14:15.407120 ignition[1133]: reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:14:15.407178 ignition[1133]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:14:15.422488 ignition[1133]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:14:15.424748 ignition[1133]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:14:15.428102 ignition[1133]: INFO : PUT result: OK Dec 13 14:14:15.432227 ignition[1133]: disks: disks passed Dec 13 14:14:15.432340 ignition[1133]: Ignition finished successfully Dec 13 14:14:15.436473 systemd[1]: Finished ignition-disks.service. Dec 13 14:14:15.437000 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:14:15.439650 systemd[1]: Reached target initrd-root-device.target. Dec 13 14:14:15.452578 kernel: audit: type=1130 audit(1734099255.437:31): 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:14:15.448356 systemd[1]: Reached target local-fs-pre.target. Dec 13 14:14:15.451058 systemd[1]: Reached target local-fs.target. Dec 13 14:14:15.452640 systemd[1]: Reached target sysinit.target. Dec 13 14:14:15.455489 systemd[1]: Reached target basic.target. Dec 13 14:14:15.459987 systemd[1]: Starting systemd-fsck-root.service... Dec 13 14:14:15.502589 systemd-fsck[1141]: ROOT: clean, 621/553520 files, 56020/553472 blocks Dec 13 14:14:15.509000 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:14:15.508966 systemd[1]: Finished systemd-fsck-root.service. Dec 13 14:14:15.520051 kernel: audit: type=1130 audit(1734099255.509:32): 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:14:15.513331 systemd[1]: Mounting sysroot.mount... Dec 13 14:14:15.542129 kernel: EXT4-fs (nvme0n1p9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Dec 13 14:14:15.543208 systemd[1]: Mounted sysroot.mount. Dec 13 14:14:15.547561 systemd[1]: Reached target initrd-root-fs.target. Dec 13 14:14:15.552983 systemd[1]: Mounting sysroot-usr.mount... Dec 13 14:14:15.556342 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Dec 13 14:14:15.556507 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Dec 13 14:14:15.557077 systemd[1]: Reached target ignition-diskful.target. Dec 13 14:14:15.574003 systemd[1]: Mounted sysroot-usr.mount. Dec 13 14:14:15.602565 systemd[1]: Mounting sysroot-usr-share-oem.mount... Dec 13 14:14:15.612185 systemd[1]: Starting initrd-setup-root.service... Dec 13 14:14:15.623345 initrd-setup-root[1163]: cut: /sysroot/etc/passwd: No such file or directory Dec 13 14:14:15.636859 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by mount (1158) Dec 13 14:14:15.642652 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Dec 13 14:14:15.642703 kernel: BTRFS info (device nvme0n1p6): using free space tree Dec 13 14:14:15.644857 kernel: BTRFS info (device nvme0n1p6): has skinny extents Dec 13 14:14:15.647195 initrd-setup-root[1176]: cut: /sysroot/etc/group: No such file or directory Dec 13 14:14:15.655612 initrd-setup-root[1195]: cut: /sysroot/etc/shadow: No such file or directory Dec 13 14:14:15.661829 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Dec 13 14:14:15.665682 systemd[1]: Mounted sysroot-usr-share-oem.mount. Dec 13 14:14:15.671458 initrd-setup-root[1205]: cut: /sysroot/etc/gshadow: No such file or directory Dec 13 14:14:15.865063 systemd[1]: Finished initrd-setup-root.service. Dec 13 14:14:15.867000 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:14:15.869865 systemd[1]: Starting ignition-mount.service... Dec 13 14:14:15.878734 kernel: audit: type=1130 audit(1734099255.867:33): 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:14:15.880027 systemd[1]: Starting sysroot-boot.service... Dec 13 14:14:15.893249 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. Dec 13 14:14:15.893460 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. Dec 13 14:14:15.921930 ignition[1223]: INFO : Ignition 2.14.0 Dec 13 14:14:15.921930 ignition[1223]: INFO : Stage: mount Dec 13 14:14:15.925204 ignition[1223]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:14:15.925204 ignition[1223]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:14:15.951899 ignition[1223]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:14:15.954199 ignition[1223]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:14:15.956972 systemd[1]: Finished sysroot-boot.service. Dec 13 14:14:15.967317 kernel: audit: type=1130 audit(1734099255.958:34): 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:14:15.958000 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:14:15.967570 ignition[1223]: INFO : PUT result: OK Dec 13 14:14:15.971357 ignition[1223]: INFO : mount: mount passed Dec 13 14:14:15.972986 ignition[1223]: INFO : Ignition finished successfully Dec 13 14:14:15.976235 systemd[1]: Finished ignition-mount.service. Dec 13 14:14:15.976000 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:14:15.985961 systemd[1]: Starting ignition-files.service... Dec 13 14:14:15.990832 kernel: audit: type=1130 audit(1734099255.976: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:14:16.003188 systemd[1]: Mounting sysroot-usr-share-oem.mount... Dec 13 14:14:16.025847 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by mount (1233) Dec 13 14:14:16.031532 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Dec 13 14:14:16.031594 kernel: BTRFS info (device nvme0n1p6): using free space tree Dec 13 14:14:16.031619 kernel: BTRFS info (device nvme0n1p6): has skinny extents Dec 13 14:14:16.040837 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Dec 13 14:14:16.045678 systemd[1]: Mounted sysroot-usr-share-oem.mount. Dec 13 14:14:16.065661 ignition[1252]: INFO : Ignition 2.14.0 Dec 13 14:14:16.067574 ignition[1252]: INFO : Stage: files Dec 13 14:14:16.069416 ignition[1252]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:14:16.071869 ignition[1252]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:14:16.087988 ignition[1252]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:14:16.090517 ignition[1252]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:14:16.093669 ignition[1252]: INFO : PUT result: OK Dec 13 14:14:16.098592 ignition[1252]: DEBUG : files: compiled without relabeling support, skipping Dec 13 14:14:16.101143 ignition[1252]: INFO : files: createFilesystemsFiles: createFiles: op(1): [started] writing file "/sysroot/etc/eks/bootstrap.sh" Dec 13 14:14:16.104488 ignition[1252]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Dec 13 14:14:16.115523 ignition[1252]: INFO : op(1): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2969340698" Dec 13 14:14:16.122897 kernel: BTRFS info: devid 1 device path /dev/nvme0n1p6 changed to /dev/disk/by-label/OEM scanned by ignition (1257) Dec 13 14:14:16.122938 ignition[1252]: CRITICAL : op(1): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2969340698": device or resource busy Dec 13 14:14:16.122938 ignition[1252]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2969340698", trying btrfs: device or resource busy Dec 13 14:14:16.122938 ignition[1252]: INFO : op(2): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2969340698" Dec 13 14:14:16.132261 ignition[1252]: INFO : op(2): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2969340698" Dec 13 14:14:16.132261 ignition[1252]: INFO : op(3): [started] unmounting "/mnt/oem2969340698" Dec 13 14:14:16.145397 ignition[1252]: INFO : op(3): [finished] unmounting "/mnt/oem2969340698" Dec 13 14:14:16.145397 ignition[1252]: INFO : files: createFilesystemsFiles: createFiles: op(1): [finished] writing file "/sysroot/etc/eks/bootstrap.sh" Dec 13 14:14:16.145397 ignition[1252]: INFO : files: createFilesystemsFiles: createFiles: op(2): [started] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Dec 13 14:14:16.154489 ignition[1252]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Dec 13 14:14:16.169942 ignition[1252]: INFO : op(4): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2107186496" Dec 13 14:14:16.169942 ignition[1252]: CRITICAL : op(4): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2107186496": device or resource busy Dec 13 14:14:16.169942 ignition[1252]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2107186496", trying btrfs: device or resource busy Dec 13 14:14:16.169942 ignition[1252]: INFO : op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2107186496" Dec 13 14:14:16.186386 ignition[1252]: INFO : op(5): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2107186496" Dec 13 14:14:16.186386 ignition[1252]: INFO : op(6): [started] unmounting "/mnt/oem2107186496" Dec 13 14:14:16.186386 ignition[1252]: INFO : op(6): [finished] unmounting "/mnt/oem2107186496" Dec 13 14:14:16.186386 ignition[1252]: INFO : files: createFilesystemsFiles: createFiles: op(2): [finished] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Dec 13 14:14:16.186386 ignition[1252]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Dec 13 14:14:16.186386 ignition[1252]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Dec 13 14:14:16.211924 ignition[1252]: INFO : op(7): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem430578100" Dec 13 14:14:16.214909 ignition[1252]: CRITICAL : op(7): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem430578100": device or resource busy Dec 13 14:14:16.214909 ignition[1252]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem430578100", trying btrfs: device or resource busy Dec 13 14:14:16.214909 ignition[1252]: INFO : op(8): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem430578100" Dec 13 14:14:16.223671 ignition[1252]: INFO : op(8): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem430578100" Dec 13 14:14:16.226466 ignition[1252]: INFO : op(9): [started] unmounting "/mnt/oem430578100" Dec 13 14:14:16.228622 ignition[1252]: INFO : op(9): [finished] unmounting "/mnt/oem430578100" Dec 13 14:14:16.228622 ignition[1252]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Dec 13 14:14:16.229361 systemd-networkd[1097]: eth0: Gained IPv6LL Dec 13 14:14:16.236244 ignition[1252]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" Dec 13 14:14:16.240689 ignition[1252]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Dec 13 14:14:16.257695 ignition[1252]: INFO : op(a): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1167829833" Dec 13 14:14:16.261178 ignition[1252]: CRITICAL : op(a): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1167829833": device or resource busy Dec 13 14:14:16.261178 ignition[1252]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem1167829833", trying btrfs: device or resource busy Dec 13 14:14:16.261178 ignition[1252]: INFO : op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1167829833" Dec 13 14:14:16.273652 ignition[1252]: INFO : op(b): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1167829833" Dec 13 14:14:16.273652 ignition[1252]: INFO : op(c): [started] unmounting "/mnt/oem1167829833" Dec 13 14:14:16.273652 ignition[1252]: INFO : op(c): [finished] unmounting "/mnt/oem1167829833" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(5): [started] processing unit "coreos-metadata-sshkeys@.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(5): [finished] processing unit "coreos-metadata-sshkeys@.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(6): [started] processing unit "amazon-ssm-agent.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(6): op(7): [started] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(6): op(7): [finished] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(6): [finished] processing unit "amazon-ssm-agent.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(8): [started] processing unit "nvidia.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(8): [finished] processing unit "nvidia.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(9): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service " Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(9): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service " Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(a): [started] setting preset to enabled for "amazon-ssm-agent.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(a): [finished] setting preset to enabled for "amazon-ssm-agent.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(b): [started] setting preset to enabled for "nvidia.service" Dec 13 14:14:16.273652 ignition[1252]: INFO : files: op(b): [finished] setting preset to enabled for "nvidia.service" Dec 13 14:14:16.328853 ignition[1252]: INFO : files: createResultFile: createFiles: op(c): [started] writing file "/sysroot/etc/.ignition-result.json" Dec 13 14:14:16.328853 ignition[1252]: INFO : files: createResultFile: createFiles: op(c): [finished] writing file "/sysroot/etc/.ignition-result.json" Dec 13 14:14:16.328853 ignition[1252]: INFO : files: files passed Dec 13 14:14:16.328853 ignition[1252]: INFO : Ignition finished successfully Dec 13 14:14:16.338283 systemd[1]: Finished ignition-files.service. Dec 13 14:14:16.345000 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:14:16.354805 kernel: audit: type=1130 audit(1734099256.345:36): 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:14:16.358063 systemd[1]: Starting initrd-setup-root-after-ignition.service... Dec 13 14:14:16.367525 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Dec 13 14:14:16.373235 systemd[1]: Starting ignition-quench.service... Dec 13 14:14:16.381482 initrd-setup-root-after-ignition[1268]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 13 14:14:16.381876 systemd[1]: ignition-quench.service: Deactivated successfully. Dec 13 14:14:16.384722 systemd[1]: Finished ignition-quench.service. Dec 13 14:14:16.387000 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:14:16.389632 systemd[1]: Finished initrd-setup-root-after-ignition.service. Dec 13 14:14:16.399630 kernel: audit: type=1130 audit(1734099256.387:37): 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:14:16.387000 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:14:16.396000 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:14:16.399734 systemd[1]: Reached target ignition-complete.target. Dec 13 14:14:16.404281 systemd[1]: Starting initrd-parse-etc.service... Dec 13 14:14:16.433891 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 13 14:14:16.435963 systemd[1]: Finished initrd-parse-etc.service. Dec 13 14:14:16.437000 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:14:16.437000 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:14:16.439431 systemd[1]: Reached target initrd-fs.target. Dec 13 14:14:16.442398 systemd[1]: Reached target initrd.target. Dec 13 14:14:16.445332 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Dec 13 14:14:16.449185 systemd[1]: Starting dracut-pre-pivot.service... Dec 13 14:14:16.473143 systemd[1]: Finished dracut-pre-pivot.service. Dec 13 14:14:16.474000 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:14:16.477493 systemd[1]: Starting initrd-cleanup.service... Dec 13 14:14:16.498173 systemd[1]: Stopped target nss-lookup.target. Dec 13 14:14:16.501561 systemd[1]: Stopped target remote-cryptsetup.target. Dec 13 14:14:16.505020 systemd[1]: Stopped target timers.target. Dec 13 14:14:16.507920 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 13 14:14:16.509956 systemd[1]: Stopped dracut-pre-pivot.service. Dec 13 14:14:16.511000 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:14:16.513211 systemd[1]: Stopped target initrd.target. Dec 13 14:14:16.516112 systemd[1]: Stopped target basic.target. Dec 13 14:14:16.518932 systemd[1]: Stopped target ignition-complete.target. Dec 13 14:14:16.522252 systemd[1]: Stopped target ignition-diskful.target. Dec 13 14:14:16.525448 systemd[1]: Stopped target initrd-root-device.target. Dec 13 14:14:16.528779 systemd[1]: Stopped target remote-fs.target. Dec 13 14:14:16.531702 systemd[1]: Stopped target remote-fs-pre.target. Dec 13 14:14:16.534851 systemd[1]: Stopped target sysinit.target. Dec 13 14:14:16.537713 systemd[1]: Stopped target local-fs.target. Dec 13 14:14:16.540609 systemd[1]: Stopped target local-fs-pre.target. Dec 13 14:14:16.543661 systemd[1]: Stopped target swap.target. Dec 13 14:14:16.546393 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 13 14:14:16.548362 systemd[1]: Stopped dracut-pre-mount.service. Dec 13 14:14:16.549000 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:14:16.551575 systemd[1]: Stopped target cryptsetup.target. Dec 13 14:14:16.554630 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 13 14:14:16.556663 systemd[1]: Stopped dracut-initqueue.service. Dec 13 14:14:16.557000 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:14:16.559895 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Dec 13 14:14:16.562174 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Dec 13 14:14:16.564000 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:14:16.565915 systemd[1]: ignition-files.service: Deactivated successfully. Dec 13 14:14:16.567836 systemd[1]: Stopped ignition-files.service. Dec 13 14:14:16.568000 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:14:16.572403 systemd[1]: Stopping ignition-mount.service... Dec 13 14:14:16.582000 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:14:16.580461 systemd[1]: Stopping iscsiuio.service... Dec 13 14:14:16.581732 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 13 14:14:16.591000 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:14:16.601000 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:14:16.582026 systemd[1]: Stopped kmod-static-nodes.service. Dec 13 14:14:16.585557 systemd[1]: Stopping sysroot-boot.service... Dec 13 14:14:16.588325 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 13 14:14:16.589912 systemd[1]: Stopped systemd-udev-trigger.service. Dec 13 14:14:16.600168 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 13 14:14:16.627424 ignition[1282]: INFO : Ignition 2.14.0 Dec 13 14:14:16.627424 ignition[1282]: INFO : Stage: umount Dec 13 14:14:16.627424 ignition[1282]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Dec 13 14:14:16.627424 ignition[1282]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Dec 13 14:14:16.600903 systemd[1]: Stopped dracut-pre-trigger.service. Dec 13 14:14:16.637674 systemd[1]: iscsiuio.service: Deactivated successfully. Dec 13 14:14:16.638654 systemd[1]: Stopped iscsiuio.service. Dec 13 14:14:16.643000 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:14:16.650689 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 13 14:14:16.652829 systemd[1]: Finished initrd-cleanup.service. Dec 13 14:14:16.654000 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:14:16.654000 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:14:16.660692 ignition[1282]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Dec 13 14:14:16.660692 ignition[1282]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Dec 13 14:14:16.662751 systemd[1]: sysroot-boot.mount: Deactivated successfully. Dec 13 14:14:16.667685 ignition[1282]: INFO : PUT result: OK Dec 13 14:14:16.673684 ignition[1282]: INFO : umount: umount passed Dec 13 14:14:16.675290 ignition[1282]: INFO : Ignition finished successfully Dec 13 14:14:16.681753 systemd[1]: ignition-mount.service: Deactivated successfully. Dec 13 14:14:16.682095 systemd[1]: Stopped ignition-mount.service. Dec 13 14:14:16.684000 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:14:16.687120 systemd[1]: sysroot-boot.service: Deactivated successfully. Dec 13 14:14:16.688634 systemd[1]: Stopped sysroot-boot.service. Dec 13 14:14:16.688000 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:14:16.690000 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:14:16.690678 systemd[1]: ignition-disks.service: Deactivated successfully. Dec 13 14:14:16.693000 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:14:16.697000 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:14:16.690806 systemd[1]: Stopped ignition-disks.service. Dec 13 14:14:16.700000 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:14:16.693139 systemd[1]: ignition-kargs.service: Deactivated successfully. Dec 13 14:14:16.693242 systemd[1]: Stopped ignition-kargs.service. Dec 13 14:14:16.696130 systemd[1]: ignition-fetch.service: Deactivated successfully. Dec 13 14:14:16.696290 systemd[1]: Stopped ignition-fetch.service. Dec 13 14:14:16.698971 systemd[1]: Stopped target network.target. Dec 13 14:14:16.700486 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Dec 13 14:14:16.700591 systemd[1]: Stopped ignition-fetch-offline.service. Dec 13 14:14:16.702187 systemd[1]: Stopped target paths.target. Dec 13 14:14:16.702361 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 13 14:14:16.706297 systemd[1]: Stopped systemd-ask-password-console.path. Dec 13 14:14:16.722842 systemd[1]: Stopped target slices.target. Dec 13 14:14:16.724287 systemd[1]: Stopped target sockets.target. Dec 13 14:14:16.726125 systemd[1]: iscsid.socket: Deactivated successfully. Dec 13 14:14:16.726186 systemd[1]: Closed iscsid.socket. Dec 13 14:14:16.731260 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 13 14:14:16.731375 systemd[1]: Closed iscsiuio.socket. Dec 13 14:14:16.738688 systemd[1]: ignition-setup.service: Deactivated successfully. Dec 13 14:14:16.738885 systemd[1]: Stopped ignition-setup.service. Dec 13 14:14:16.740000 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:14:16.743632 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 13 14:14:16.743753 systemd[1]: Stopped initrd-setup-root.service. Dec 13 14:14:16.747000 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:14:16.749321 systemd[1]: Stopping systemd-networkd.service... Dec 13 14:14:16.752735 systemd[1]: Stopping systemd-resolved.service... Dec 13 14:14:16.753868 systemd-networkd[1097]: eth0: DHCPv6 lease lost Dec 13 14:14:16.757730 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 13 14:14:16.759693 systemd[1]: Stopped systemd-networkd.service. Dec 13 14:14:16.759000 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:14:16.761000 audit: BPF prog-id=9 op=UNLOAD Dec 13 14:14:16.763539 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 13 14:14:16.763628 systemd[1]: Closed systemd-networkd.socket. Dec 13 14:14:16.771089 systemd[1]: Stopping network-cleanup.service... Dec 13 14:14:16.774198 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Dec 13 14:14:16.775000 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:14:16.779000 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:14:16.775573 systemd[1]: Stopped parse-ip-for-networkd.service. Dec 13 14:14:16.782000 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:14:16.778420 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 13 14:14:16.778542 systemd[1]: Stopped systemd-sysctl.service. Dec 13 14:14:16.781189 systemd[1]: systemd-modules-load.service: Deactivated successfully. Dec 13 14:14:16.793000 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:14:16.781292 systemd[1]: Stopped systemd-modules-load.service. Dec 13 14:14:16.784574 systemd[1]: Stopping systemd-udevd.service... Dec 13 14:14:16.801000 audit: BPF prog-id=6 op=UNLOAD Dec 13 14:14:16.789180 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Dec 13 14:14:16.793109 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 13 14:14:16.793342 systemd[1]: Stopped systemd-resolved.service. Dec 13 14:14:16.813354 systemd[1]: network-cleanup.service: Deactivated successfully. Dec 13 14:14:16.814000 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:14:16.813612 systemd[1]: Stopped network-cleanup.service. Dec 13 14:14:16.823342 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 13 14:14:16.823000 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:14:16.823626 systemd[1]: Stopped systemd-udevd.service. Dec 13 14:14:16.829243 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 13 14:14:16.829346 systemd[1]: Closed systemd-udevd-control.socket. Dec 13 14:14:16.834464 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 13 14:14:16.834587 systemd[1]: Closed systemd-udevd-kernel.socket. Dec 13 14:14:16.837960 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 13 14:14:16.841267 systemd[1]: Stopped dracut-pre-udev.service. Dec 13 14:14:16.842000 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:14:16.844333 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 13 14:14:16.844465 systemd[1]: Stopped dracut-cmdline.service. Dec 13 14:14:16.847000 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:14:16.849486 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 13 14:14:16.849580 systemd[1]: Stopped dracut-cmdline-ask.service. Dec 13 14:14:16.851000 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:14:16.856188 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Dec 13 14:14:16.872916 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 13 14:14:16.874000 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:14:16.877000 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:14:16.878000 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:14:16.874459 systemd[1]: Stopped systemd-vconsole-setup.service. Dec 13 14:14:16.877436 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 13 14:14:16.877657 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Dec 13 14:14:16.880078 systemd[1]: Reached target initrd-switch-root.target. Dec 13 14:14:16.883166 systemd[1]: Starting initrd-switch-root.service... Dec 13 14:14:16.898952 systemd[1]: Switching root. Dec 13 14:14:16.934381 iscsid[1102]: iscsid shutting down. Dec 13 14:14:16.935874 systemd-journald[309]: Received SIGTERM from PID 1 (n/a). Dec 13 14:14:16.935957 systemd-journald[309]: Journal stopped Dec 13 14:14:23.260446 kernel: SELinux: Class mctp_socket not defined in policy. Dec 13 14:14:23.265096 kernel: SELinux: Class anon_inode not defined in policy. Dec 13 14:14:23.265157 kernel: SELinux: the above unknown classes and permissions will be allowed Dec 13 14:14:23.265191 kernel: SELinux: policy capability network_peer_controls=1 Dec 13 14:14:23.265230 kernel: SELinux: policy capability open_perms=1 Dec 13 14:14:23.265262 kernel: SELinux: policy capability extended_socket_class=1 Dec 13 14:14:23.265293 kernel: SELinux: policy capability always_check_network=0 Dec 13 14:14:23.265325 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 13 14:14:23.265361 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 13 14:14:23.265393 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 13 14:14:23.265424 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Dec 13 14:14:23.265459 systemd[1]: Successfully loaded SELinux policy in 130.427ms. Dec 13 14:14:23.265515 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 30.678ms. Dec 13 14:14:23.265568 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:14:23.265610 systemd[1]: Detected virtualization amazon. Dec 13 14:14:23.265644 systemd[1]: Detected architecture arm64. Dec 13 14:14:23.265677 systemd[1]: Detected first boot. Dec 13 14:14:23.265722 systemd[1]: Initializing machine ID from VM UUID. Dec 13 14:14:23.265761 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Dec 13 14:14:23.265845 systemd[1]: Populated /etc with preset unit settings. Dec 13 14:14:23.265905 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:14:23.265947 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:14:23.265983 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:14:23.266015 kernel: kauditd_printk_skb: 55 callbacks suppressed Dec 13 14:14:23.266046 kernel: audit: type=1334 audit(1734099262.846:86): prog-id=12 op=LOAD Dec 13 14:14:23.266074 kernel: audit: type=1334 audit(1734099262.847:87): prog-id=3 op=UNLOAD Dec 13 14:14:23.266104 kernel: audit: type=1334 audit(1734099262.848:88): prog-id=13 op=LOAD Dec 13 14:14:23.266140 systemd[1]: iscsid.service: Deactivated successfully. Dec 13 14:14:23.266171 kernel: audit: type=1334 audit(1734099262.851:89): prog-id=14 op=LOAD Dec 13 14:14:23.266201 systemd[1]: Stopped iscsid.service. Dec 13 14:14:23.266234 kernel: audit: type=1334 audit(1734099262.851:90): prog-id=4 op=UNLOAD Dec 13 14:14:23.266270 kernel: audit: type=1334 audit(1734099262.851:91): prog-id=5 op=UNLOAD Dec 13 14:14:23.266299 kernel: audit: type=1131 audit(1734099262.851:92): 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:14:23.266329 kernel: audit: type=1334 audit(1734099262.861:93): prog-id=12 op=UNLOAD Dec 13 14:14:23.266360 kernel: audit: type=1131 audit(1734099262.875:94): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:14:23.266396 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 13 14:14:23.266426 systemd[1]: Stopped initrd-switch-root.service. Dec 13 14:14:23.266458 kernel: audit: type=1130 audit(1734099262.889:95): 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:14:23.266487 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 13 14:14:23.266518 systemd[1]: Created slice system-addon\x2dconfig.slice. Dec 13 14:14:23.266551 systemd[1]: Created slice system-addon\x2drun.slice. Dec 13 14:14:23.266584 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice. Dec 13 14:14:23.266621 systemd[1]: Created slice system-getty.slice. Dec 13 14:14:23.266654 systemd[1]: Created slice system-modprobe.slice. Dec 13 14:14:23.266686 systemd[1]: Created slice system-serial\x2dgetty.slice. Dec 13 14:14:23.266718 systemd[1]: Created slice system-system\x2dcloudinit.slice. Dec 13 14:14:23.266749 systemd[1]: Created slice system-systemd\x2dfsck.slice. Dec 13 14:14:23.266803 systemd[1]: Created slice user.slice. Dec 13 14:14:23.266840 systemd[1]: Started systemd-ask-password-console.path. Dec 13 14:14:23.266871 systemd[1]: Started systemd-ask-password-wall.path. Dec 13 14:14:23.266904 systemd[1]: Set up automount boot.automount. Dec 13 14:14:23.266938 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Dec 13 14:14:23.266973 systemd[1]: Stopped target initrd-switch-root.target. Dec 13 14:14:23.267002 systemd[1]: Stopped target initrd-fs.target. Dec 13 14:14:23.267034 systemd[1]: Stopped target initrd-root-fs.target. Dec 13 14:14:23.267063 systemd[1]: Reached target integritysetup.target. Dec 13 14:14:23.267092 systemd[1]: Reached target remote-cryptsetup.target. Dec 13 14:14:23.267124 systemd[1]: Reached target remote-fs.target. Dec 13 14:14:23.267154 systemd[1]: Reached target slices.target. Dec 13 14:14:23.267184 systemd[1]: Reached target swap.target. Dec 13 14:14:23.267217 systemd[1]: Reached target torcx.target. Dec 13 14:14:23.267249 systemd[1]: Reached target veritysetup.target. Dec 13 14:14:23.267281 systemd[1]: Listening on systemd-coredump.socket. Dec 13 14:14:23.267313 systemd[1]: Listening on systemd-initctl.socket. Dec 13 14:14:23.267345 systemd[1]: Listening on systemd-networkd.socket. Dec 13 14:14:23.267387 systemd[1]: Listening on systemd-udevd-control.socket. Dec 13 14:14:23.267421 systemd[1]: Listening on systemd-udevd-kernel.socket. Dec 13 14:14:23.267453 systemd[1]: Listening on systemd-userdbd.socket. Dec 13 14:14:23.267485 systemd[1]: Mounting dev-hugepages.mount... Dec 13 14:14:23.267518 systemd[1]: Mounting dev-mqueue.mount... Dec 13 14:14:23.267553 systemd[1]: Mounting media.mount... Dec 13 14:14:23.267583 systemd[1]: Mounting sys-kernel-debug.mount... Dec 13 14:14:23.267613 systemd[1]: Mounting sys-kernel-tracing.mount... Dec 13 14:14:23.267645 systemd[1]: Mounting tmp.mount... Dec 13 14:14:23.267675 systemd[1]: Starting flatcar-tmpfiles.service... Dec 13 14:14:23.267705 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Dec 13 14:14:23.267734 systemd[1]: Starting kmod-static-nodes.service... Dec 13 14:14:23.267763 systemd[1]: Starting modprobe@configfs.service... Dec 13 14:14:23.267810 systemd[1]: Starting modprobe@dm_mod.service... Dec 13 14:14:23.267848 systemd[1]: Starting modprobe@drm.service... Dec 13 14:14:23.267881 systemd[1]: Starting modprobe@efi_pstore.service... Dec 13 14:14:23.267915 systemd[1]: Starting modprobe@fuse.service... Dec 13 14:14:23.267956 systemd[1]: Starting modprobe@loop.service... Dec 13 14:14:23.267988 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Dec 13 14:14:23.268018 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 13 14:14:23.268047 systemd[1]: Stopped systemd-fsck-root.service. Dec 13 14:14:23.268079 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 13 14:14:23.268108 systemd[1]: Stopped systemd-fsck-usr.service. Dec 13 14:14:23.268144 systemd[1]: Stopped systemd-journald.service. Dec 13 14:14:23.268174 systemd[1]: Starting systemd-journald.service... Dec 13 14:14:23.268205 systemd[1]: Starting systemd-modules-load.service... Dec 13 14:14:23.268235 systemd[1]: Starting systemd-network-generator.service... Dec 13 14:14:23.268264 kernel: fuse: init (API version 7.34) Dec 13 14:14:23.268293 systemd[1]: Starting systemd-remount-fs.service... Dec 13 14:14:23.268325 systemd[1]: Starting systemd-udev-trigger.service... Dec 13 14:14:23.268357 systemd[1]: verity-setup.service: Deactivated successfully. Dec 13 14:14:23.268387 systemd[1]: Stopped verity-setup.service. Dec 13 14:14:23.268420 systemd[1]: Mounted dev-hugepages.mount. Dec 13 14:14:23.272888 systemd[1]: Mounted dev-mqueue.mount. Dec 13 14:14:23.272943 systemd[1]: Mounted media.mount. Dec 13 14:14:23.272975 systemd[1]: Mounted sys-kernel-debug.mount. Dec 13 14:14:23.273006 systemd[1]: Mounted sys-kernel-tracing.mount. Dec 13 14:14:23.273046 systemd[1]: Mounted tmp.mount. Dec 13 14:14:23.273086 systemd[1]: Finished kmod-static-nodes.service. Dec 13 14:14:23.273116 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 13 14:14:23.273147 systemd[1]: Finished modprobe@configfs.service. Dec 13 14:14:23.273186 kernel: loop: module loaded Dec 13 14:14:23.273217 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 14:14:23.273246 systemd[1]: Finished modprobe@dm_mod.service. Dec 13 14:14:23.273276 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 13 14:14:23.273306 systemd[1]: Finished modprobe@drm.service. Dec 13 14:14:23.273339 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 14:14:23.273372 systemd[1]: Finished modprobe@efi_pstore.service. Dec 13 14:14:23.273402 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 13 14:14:23.273433 systemd[1]: Finished modprobe@fuse.service. Dec 13 14:14:23.273464 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 14:14:23.273493 systemd[1]: Finished modprobe@loop.service. Dec 13 14:14:23.273533 systemd[1]: Finished systemd-modules-load.service. Dec 13 14:14:23.273570 systemd-journald[1390]: Journal started Dec 13 14:14:23.273681 systemd-journald[1390]: Runtime Journal (/run/log/journal/ec24a300f95b3ccf34627bc389dafce3) is 8.0M, max 75.4M, 67.4M free. Dec 13 14:14:18.020000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 13 14:14:18.219000 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:14:18.219000 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:14:18.219000 audit: BPF prog-id=10 op=LOAD Dec 13 14:14:18.219000 audit: BPF prog-id=10 op=UNLOAD Dec 13 14:14:18.219000 audit: BPF prog-id=11 op=LOAD Dec 13 14:14:18.219000 audit: BPF prog-id=11 op=UNLOAD Dec 13 14:14:18.488000 audit[1315]: AVC avc: denied { associate } for pid=1315 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:14:18.488000 audit[1315]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=40001458ac a1=40000c6de0 a2=40000cd0c0 a3=32 items=0 ppid=1298 pid=1315 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:14:18.488000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Dec 13 14:14:18.492000 audit[1315]: AVC avc: denied { associate } for pid=1315 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:14:18.492000 audit[1315]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=4000145985 a2=1ed a3=0 items=2 ppid=1298 pid=1315 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:14:18.492000 audit: CWD cwd="/" Dec 13 14:14:18.492000 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:14:18.492000 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:14:18.492000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Dec 13 14:14:22.846000 audit: BPF prog-id=12 op=LOAD Dec 13 14:14:22.847000 audit: BPF prog-id=3 op=UNLOAD Dec 13 14:14:22.848000 audit: BPF prog-id=13 op=LOAD Dec 13 14:14:22.851000 audit: BPF prog-id=14 op=LOAD Dec 13 14:14:22.851000 audit: BPF prog-id=4 op=UNLOAD Dec 13 14:14:22.851000 audit: BPF prog-id=5 op=UNLOAD Dec 13 14:14:22.851000 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:14:22.861000 audit: BPF prog-id=12 op=UNLOAD Dec 13 14:14:22.875000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:14:22.889000 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:14:22.889000 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:14:23.129000 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:14:23.137000 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:14:23.141000 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:14:23.141000 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:14:23.143000 audit: BPF prog-id=15 op=LOAD Dec 13 14:14:23.143000 audit: BPF prog-id=16 op=LOAD Dec 13 14:14:23.143000 audit: BPF prog-id=17 op=LOAD Dec 13 14:14:23.143000 audit: BPF prog-id=13 op=UNLOAD Dec 13 14:14:23.143000 audit: BPF prog-id=14 op=UNLOAD Dec 13 14:14:23.186000 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:14:23.217000 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:14:23.226000 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:14:23.226000 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:14:23.235000 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:14:23.235000 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:14:23.280518 systemd[1]: Started systemd-journald.service. Dec 13 14:14:23.243000 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:14:23.243000 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:14:23.253000 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:14:23.253000 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:14:23.256000 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:14:23.256000 audit[1390]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=ffffc9ac53f0 a2=4000 a3=1 items=0 ppid=1 pid=1390 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:14:23.256000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Dec 13 14:14:23.260000 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:14:23.260000 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:14:23.269000 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:14:23.269000 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:14:23.275000 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:14:23.279000 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:14:23.281000 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:14:23.284000 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:14:22.843190 systemd[1]: Queued start job for default target multi-user.target. Dec 13 14:14:18.485377 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" 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:14:22.853507 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 13 14:14:18.486680 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 13 14:14:23.281228 systemd[1]: Finished systemd-network-generator.service. Dec 13 14:14:18.486733 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 13 14:14:23.283515 systemd[1]: Finished systemd-remount-fs.service. Dec 13 14:14:18.486829 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Dec 13 14:14:23.285961 systemd[1]: Reached target network-pre.target. Dec 13 14:14:18.486856 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" level=debug msg="skipped missing lower profile" missing profile=oem Dec 13 14:14:23.290604 systemd[1]: Mounting sys-fs-fuse-connections.mount... Dec 13 14:14:18.486929 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Dec 13 14:14:23.300407 systemd[1]: Mounting sys-kernel-config.mount... Dec 13 14:14:18.486962 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Dec 13 14:14:23.302961 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Dec 13 14:14:18.487399 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Dec 13 14:14:23.306778 systemd[1]: Starting systemd-hwdb-update.service... Dec 13 14:14:18.487490 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Dec 13 14:14:23.312258 systemd[1]: Starting systemd-journal-flush.service... Dec 13 14:14:18.487527 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Dec 13 14:14:23.314166 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 13 14:14:18.488763 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" 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:14:18.488889 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" 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:14:18.488940 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" 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:14:18.488981 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" 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:14:18.489030 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" 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:14:18.489069 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:18Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Dec 13 14:14:21.918917 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:21Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Dec 13 14:14:21.919447 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:21Z" 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:14:21.919693 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:21Z" 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:14:21.920193 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:21Z" 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:14:23.317663 systemd[1]: Starting systemd-random-seed.service... Dec 13 14:14:21.920298 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:21Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Dec 13 14:14:23.319470 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Dec 13 14:14:21.920443 /usr/lib/systemd/system-generators/torcx-generator[1315]: time="2024-12-13T14:14:21Z" 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:14:23.328130 systemd[1]: Starting systemd-sysctl.service... Dec 13 14:14:23.341348 systemd[1]: Mounted sys-fs-fuse-connections.mount. Dec 13 14:14:23.343516 systemd[1]: Mounted sys-kernel-config.mount. Dec 13 14:14:23.361677 systemd[1]: Finished systemd-random-seed.service. Dec 13 14:14:23.362000 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:14:23.363741 systemd[1]: Reached target first-boot-complete.target. Dec 13 14:14:23.373980 systemd-journald[1390]: Time spent on flushing to /var/log/journal/ec24a300f95b3ccf34627bc389dafce3 is 52.975ms for 1095 entries. Dec 13 14:14:23.373980 systemd-journald[1390]: System Journal (/var/log/journal/ec24a300f95b3ccf34627bc389dafce3) is 8.0M, max 195.6M, 187.6M free. Dec 13 14:14:23.445328 systemd-journald[1390]: Received client request to flush runtime journal. Dec 13 14:14:23.407000 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:14:23.406412 systemd[1]: Finished systemd-sysctl.service. Dec 13 14:14:23.446975 systemd[1]: Finished systemd-journal-flush.service. Dec 13 14:14:23.447000 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:14:23.471760 systemd[1]: Finished flatcar-tmpfiles.service. Dec 13 14:14:23.472000 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:14:23.476221 systemd[1]: Starting systemd-sysusers.service... Dec 13 14:14:23.512486 systemd[1]: Finished systemd-udev-trigger.service. Dec 13 14:14:23.513000 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:14:23.518105 systemd[1]: Starting systemd-udev-settle.service... Dec 13 14:14:23.537491 udevadm[1434]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Dec 13 14:14:23.708734 systemd[1]: Finished systemd-sysusers.service. Dec 13 14:14:23.709000 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:14:24.266381 systemd[1]: Finished systemd-hwdb-update.service. Dec 13 14:14:24.267000 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:14:24.268000 audit: BPF prog-id=18 op=LOAD Dec 13 14:14:24.268000 audit: BPF prog-id=19 op=LOAD Dec 13 14:14:24.268000 audit: BPF prog-id=7 op=UNLOAD Dec 13 14:14:24.268000 audit: BPF prog-id=8 op=UNLOAD Dec 13 14:14:24.271474 systemd[1]: Starting systemd-udevd.service... Dec 13 14:14:24.310672 systemd-udevd[1435]: Using default interface naming scheme 'v252'. Dec 13 14:14:24.371988 systemd[1]: Started systemd-udevd.service. Dec 13 14:14:24.372000 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:14:24.373000 audit: BPF prog-id=20 op=LOAD Dec 13 14:14:24.380580 systemd[1]: Starting systemd-networkd.service... Dec 13 14:14:24.396000 audit: BPF prog-id=21 op=LOAD Dec 13 14:14:24.396000 audit: BPF prog-id=22 op=LOAD Dec 13 14:14:24.396000 audit: BPF prog-id=23 op=LOAD Dec 13 14:14:24.402983 systemd[1]: Starting systemd-userdbd.service... Dec 13 14:14:24.460160 (udev-worker)[1441]: Network interface NamePolicy= disabled on kernel command line. Dec 13 14:14:24.472000 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:14:24.471925 systemd[1]: Started systemd-userdbd.service. Dec 13 14:14:24.483458 systemd[1]: Condition check resulted in dev-ttyS0.device being skipped. Dec 13 14:14:24.654922 kernel: BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/nvme0n1p6 scanned by (udev-worker) (1438) Dec 13 14:14:24.669946 systemd-networkd[1444]: lo: Link UP Dec 13 14:14:24.669970 systemd-networkd[1444]: lo: Gained carrier Dec 13 14:14:24.671064 systemd-networkd[1444]: Enumeration completed Dec 13 14:14:24.671314 systemd[1]: Started systemd-networkd.service. Dec 13 14:14:24.671371 systemd-networkd[1444]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 13 14:14:24.671000 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:14:24.676298 systemd[1]: Starting systemd-networkd-wait-online.service... Dec 13 14:14:24.680852 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Dec 13 14:14:24.681057 systemd-networkd[1444]: eth0: Link UP Dec 13 14:14:24.681514 systemd-networkd[1444]: eth0: Gained carrier Dec 13 14:14:24.700079 systemd-networkd[1444]: eth0: DHCPv4 address 172.31.18.236/20, gateway 172.31.16.1 acquired from 172.31.16.1 Dec 13 14:14:24.865439 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Dec 13 14:14:24.868155 systemd[1]: Finished systemd-udev-settle.service. Dec 13 14:14:24.868000 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:14:24.872205 systemd[1]: Starting lvm2-activation-early.service... Dec 13 14:14:24.935587 lvm[1549]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 13 14:14:24.973314 systemd[1]: Finished lvm2-activation-early.service. Dec 13 14:14:24.974000 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:14:24.975276 systemd[1]: Reached target cryptsetup.target. Dec 13 14:14:24.979112 systemd[1]: Starting lvm2-activation.service... Dec 13 14:14:24.987701 lvm[1550]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 13 14:14:25.024463 systemd[1]: Finished lvm2-activation.service. Dec 13 14:14:25.025000 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:14:25.026341 systemd[1]: Reached target local-fs-pre.target. Dec 13 14:14:25.028101 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Dec 13 14:14:25.028293 systemd[1]: Reached target local-fs.target. Dec 13 14:14:25.029956 systemd[1]: Reached target machines.target. Dec 13 14:14:25.033869 systemd[1]: Starting ldconfig.service... Dec 13 14:14:25.036920 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Dec 13 14:14:25.037251 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:14:25.039609 systemd[1]: Starting systemd-boot-update.service... Dec 13 14:14:25.043879 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Dec 13 14:14:25.048572 systemd[1]: Starting systemd-machine-id-commit.service... Dec 13 14:14:25.050965 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Dec 13 14:14:25.051115 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Dec 13 14:14:25.054548 systemd[1]: Starting systemd-tmpfiles-setup.service... Dec 13 14:14:25.076269 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1552 (bootctl) Dec 13 14:14:25.079018 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Dec 13 14:14:25.110971 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Dec 13 14:14:25.113557 systemd[1]: Finished systemd-machine-id-commit.service. Dec 13 14:14:25.112000 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:14:25.119196 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Dec 13 14:14:25.117000 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:14:25.142217 systemd-tmpfiles[1555]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Dec 13 14:14:25.175049 systemd-tmpfiles[1555]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Dec 13 14:14:25.219169 systemd-tmpfiles[1555]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Dec 13 14:14:25.234185 systemd-fsck[1560]: fsck.fat 4.2 (2021-01-31) Dec 13 14:14:25.234185 systemd-fsck[1560]: /dev/nvme0n1p1: 236 files, 117175/258078 clusters Dec 13 14:14:25.239390 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Dec 13 14:14:25.239000 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:14:25.245930 systemd[1]: Mounting boot.mount... Dec 13 14:14:25.276319 systemd[1]: Mounted boot.mount. Dec 13 14:14:25.303813 systemd[1]: Finished systemd-boot-update.service. Dec 13 14:14:25.304000 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:14:25.543138 systemd[1]: Finished systemd-tmpfiles-setup.service. Dec 13 14:14:25.543000 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:14:25.548321 systemd[1]: Starting audit-rules.service... Dec 13 14:14:25.552537 systemd[1]: Starting clean-ca-certificates.service... Dec 13 14:14:25.559031 systemd[1]: Starting systemd-journal-catalog-update.service... Dec 13 14:14:25.562000 audit: BPF prog-id=24 op=LOAD Dec 13 14:14:25.568000 audit: BPF prog-id=25 op=LOAD Dec 13 14:14:25.566431 systemd[1]: Starting systemd-resolved.service... Dec 13 14:14:25.573112 systemd[1]: Starting systemd-timesyncd.service... Dec 13 14:14:25.578567 systemd[1]: Starting systemd-update-utmp.service... Dec 13 14:14:25.592000 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:14:25.592654 systemd[1]: Finished clean-ca-certificates.service. Dec 13 14:14:25.594634 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Dec 13 14:14:25.602000 audit[1580]: SYSTEM_BOOT pid=1580 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:14:25.613402 systemd[1]: Finished systemd-update-utmp.service. Dec 13 14:14:25.613000 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:14:25.657000 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:14:25.657248 systemd[1]: Finished systemd-journal-catalog-update.service. Dec 13 14:14:25.726000 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:14:25.726000 audit[1594]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffecb52270 a2=420 a3=0 items=0 ppid=1574 pid=1594 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:14:25.726000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Dec 13 14:14:25.729061 augenrules[1594]: No rules Dec 13 14:14:25.731010 systemd[1]: Finished audit-rules.service. Dec 13 14:14:25.742341 systemd[1]: Started systemd-timesyncd.service. Dec 13 14:14:25.744348 systemd[1]: Reached target time-set.target. Dec 13 14:14:25.759239 systemd-resolved[1578]: Positive Trust Anchors: Dec 13 14:14:25.760028 systemd-resolved[1578]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 13 14:14:25.760235 systemd-resolved[1578]: 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:14:25.815729 systemd-resolved[1578]: Defaulting to hostname 'linux'. Dec 13 14:14:25.819329 systemd[1]: Started systemd-resolved.service. Dec 13 14:14:25.821137 systemd[1]: Reached target network.target. Dec 13 14:14:25.822620 systemd[1]: Reached target nss-lookup.target. Dec 13 14:14:25.889451 systemd-timesyncd[1579]: Contacted time server 74.208.25.46:123 (0.flatcar.pool.ntp.org). Dec 13 14:14:25.889582 systemd-timesyncd[1579]: Initial clock synchronization to Fri 2024-12-13 14:14:25.571914 UTC. Dec 13 14:14:26.346598 ldconfig[1551]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Dec 13 14:14:26.355815 systemd[1]: Finished ldconfig.service. Dec 13 14:14:26.359941 systemd[1]: Starting systemd-update-done.service... Dec 13 14:14:26.375578 systemd[1]: Finished systemd-update-done.service. Dec 13 14:14:26.377560 systemd[1]: Reached target sysinit.target. Dec 13 14:14:26.379286 systemd[1]: Started motdgen.path. Dec 13 14:14:26.380966 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Dec 13 14:14:26.383445 systemd[1]: Started logrotate.timer. Dec 13 14:14:26.385264 systemd[1]: Started mdadm.timer. Dec 13 14:14:26.386760 systemd[1]: Started systemd-tmpfiles-clean.timer. Dec 13 14:14:26.388632 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Dec 13 14:14:26.388729 systemd[1]: Reached target paths.target. Dec 13 14:14:26.390370 systemd[1]: Reached target timers.target. Dec 13 14:14:26.392484 systemd[1]: Listening on dbus.socket. Dec 13 14:14:26.396412 systemd[1]: Starting docker.socket... Dec 13 14:14:26.403558 systemd[1]: Listening on sshd.socket. Dec 13 14:14:26.405344 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:14:26.406264 systemd[1]: Listening on docker.socket. Dec 13 14:14:26.408084 systemd[1]: Reached target sockets.target. Dec 13 14:14:26.409664 systemd[1]: Reached target basic.target. Dec 13 14:14:26.411187 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Dec 13 14:14:26.411248 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Dec 13 14:14:26.413508 systemd[1]: Starting containerd.service... Dec 13 14:14:26.417667 systemd[1]: Starting coreos-metadata-sshkeys@core.service... Dec 13 14:14:26.422849 systemd[1]: Starting dbus.service... Dec 13 14:14:26.427238 systemd[1]: Starting enable-oem-cloudinit.service... Dec 13 14:14:26.434950 systemd[1]: Starting extend-filesystems.service... Dec 13 14:14:26.437571 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:14:26.440944 systemd[1]: Starting motdgen.service... Dec 13 14:14:26.504240 jq[1606]: true Dec 13 14:14:26.446979 systemd[1]: Starting ssh-key-proc-cmdline.service... Dec 13 14:14:26.451629 systemd[1]: Starting sshd-keygen.service... Dec 13 14:14:26.463111 systemd[1]: Starting systemd-logind.service... Dec 13 14:14:26.464610 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:14:26.464739 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Dec 13 14:14:26.465660 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 13 14:14:26.522960 jq[1614]: false Dec 13 14:14:26.467992 systemd[1]: Starting update-engine.service... Dec 13 14:14:26.473066 systemd[1]: Starting update-ssh-keys-after-ignition.service... Dec 13 14:14:26.533223 jq[1616]: true Dec 13 14:14:26.483055 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 13 14:14:26.484656 systemd[1]: Finished ssh-key-proc-cmdline.service. Dec 13 14:14:26.491518 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Dec 13 14:14:26.491915 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service being skipped. Dec 13 14:14:26.571531 dbus-daemon[1605]: [system] SELinux support is enabled Dec 13 14:14:26.571874 systemd[1]: Started dbus.service. Dec 13 14:14:26.576615 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:14:26.576659 systemd[1]: Reached target system-config.target. Dec 13 14:14:26.578673 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Dec 13 14:14:26.578713 systemd[1]: Reached target user-config.target. Dec 13 14:14:26.586971 dbus-daemon[1605]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1444 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Dec 13 14:14:26.594330 dbus-daemon[1605]: [system] Successfully activated service 'org.freedesktop.systemd1' Dec 13 14:14:26.594902 systemctl[1623]: Created symlink /etc/systemd/system/multi-user.target.wants/oem-cloudinit.service → /usr/lib/systemd/system/oem-cloudinit.service. Dec 13 14:14:26.598812 systemd[1]: Reloading. Dec 13 14:14:26.607601 extend-filesystems[1607]: Found nvme0n1 Dec 13 14:14:26.607601 extend-filesystems[1607]: Found nvme0n1p1 Dec 13 14:14:26.607601 extend-filesystems[1607]: Found nvme0n1p2 Dec 13 14:14:26.607601 extend-filesystems[1607]: Found nvme0n1p3 Dec 13 14:14:26.607601 extend-filesystems[1607]: Found usr Dec 13 14:14:26.607601 extend-filesystems[1607]: Found nvme0n1p4 Dec 13 14:14:26.607601 extend-filesystems[1607]: Found nvme0n1p6 Dec 13 14:14:26.607601 extend-filesystems[1607]: Found nvme0n1p7 Dec 13 14:14:26.607601 extend-filesystems[1607]: Found nvme0n1p9 Dec 13 14:14:26.607601 extend-filesystems[1607]: Checking size of /dev/nvme0n1p9 Dec 13 14:14:26.692338 update_engine[1613]: I1213 14:14:26.691888 1613 main.cc:92] Flatcar Update Engine starting Dec 13 14:14:26.702815 update_engine[1613]: I1213 14:14:26.698628 1613 update_check_scheduler.cc:74] Next update check in 5m46s Dec 13 14:14:26.713877 extend-filesystems[1607]: Resized partition /dev/nvme0n1p9 Dec 13 14:14:26.724974 systemd-networkd[1444]: eth0: Gained IPv6LL Dec 13 14:14:26.740688 extend-filesystems[1658]: resize2fs 1.46.5 (30-Dec-2021) Dec 13 14:14:26.775813 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Dec 13 14:14:26.822236 env[1618]: time="2024-12-13T14:14:26.820352897Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Dec 13 14:14:26.831940 /usr/lib/systemd/system-generators/torcx-generator[1665]: time="2024-12-13T14:14:26Z" 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:14:26.832036 /usr/lib/systemd/system-generators/torcx-generator[1665]: time="2024-12-13T14:14:26Z" level=info msg="torcx already run" Dec 13 14:14:26.889356 systemd-logind[1612]: Watching system buttons on /dev/input/event0 (Power Button) Dec 13 14:14:26.889447 systemd-logind[1612]: Watching system buttons on /dev/input/event1 (Sleep Button) Dec 13 14:14:26.890031 systemd-logind[1612]: New seat seat0. Dec 13 14:14:26.895964 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Dec 13 14:14:26.910094 extend-filesystems[1658]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Dec 13 14:14:26.910094 extend-filesystems[1658]: old_desc_blocks = 1, new_desc_blocks = 1 Dec 13 14:14:26.910094 extend-filesystems[1658]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Dec 13 14:14:26.916982 extend-filesystems[1607]: Resized filesystem in /dev/nvme0n1p9 Dec 13 14:14:27.039839 env[1618]: time="2024-12-13T14:14:27.035180481Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Dec 13 14:14:27.039839 env[1618]: time="2024-12-13T14:14:27.035452971Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Dec 13 14:14:27.042129 env[1618]: time="2024-12-13T14:14:27.042055787Z" 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:14:27.042342 env[1618]: time="2024-12-13T14:14:27.042309442Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Dec 13 14:14:27.048822 env[1618]: time="2024-12-13T14:14:27.042813635Z" 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:14:27.050881 env[1618]: time="2024-12-13T14:14:27.050829657Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Dec 13 14:14:27.056926 env[1618]: time="2024-12-13T14:14:27.056867560Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Dec 13 14:14:27.057132 env[1618]: time="2024-12-13T14:14:27.057100978Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Dec 13 14:14:27.057438 env[1618]: time="2024-12-13T14:14:27.057408519Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Dec 13 14:14:27.064811 env[1618]: time="2024-12-13T14:14:27.058015435Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Dec 13 14:14:27.075209 env[1618]: time="2024-12-13T14:14:27.075151742Z" 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:14:27.075412 env[1618]: time="2024-12-13T14:14:27.075380110Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Dec 13 14:14:27.075649 env[1618]: time="2024-12-13T14:14:27.075617200Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Dec 13 14:14:27.077036 env[1618]: time="2024-12-13T14:14:27.076989968Z" level=info msg="metadata content store policy set" policy=shared Dec 13 14:14:27.101060 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:14:27.101090 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:14:27.114817 env[1618]: time="2024-12-13T14:14:27.107277327Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.107350094Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.107381416Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.107453789Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.107490879Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.107523545Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.107555075Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.108081856Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.108122306Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.108151832Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.108180767Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.108210965Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.108450639Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Dec 13 14:14:27.114817 env[1618]: time="2024-12-13T14:14:27.108607062Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Dec 13 14:14:27.115980 env[1618]: time="2024-12-13T14:14:27.115933532Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Dec 13 14:14:27.116140 env[1618]: time="2024-12-13T14:14:27.116108952Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.116270 env[1618]: time="2024-12-13T14:14:27.116240054Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Dec 13 14:14:27.116483 env[1618]: time="2024-12-13T14:14:27.116452355Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.116652 env[1618]: time="2024-12-13T14:14:27.116602222Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.116835 env[1618]: time="2024-12-13T14:14:27.116757313Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.116959 env[1618]: time="2024-12-13T14:14:27.116928551Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.117079 env[1618]: time="2024-12-13T14:14:27.117050491Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.117196 env[1618]: time="2024-12-13T14:14:27.117168109Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.117316 env[1618]: time="2024-12-13T14:14:27.117287430Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.117433 env[1618]: time="2024-12-13T14:14:27.117405663Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.117590 env[1618]: time="2024-12-13T14:14:27.117560163Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Dec 13 14:14:27.121816 env[1618]: time="2024-12-13T14:14:27.117980446Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.122047 env[1618]: time="2024-12-13T14:14:27.122005062Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.122169 env[1618]: time="2024-12-13T14:14:27.122140715Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.122318 env[1618]: time="2024-12-13T14:14:27.122289204Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Dec 13 14:14:27.122442 env[1618]: time="2024-12-13T14:14:27.122409614Z" 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:14:27.122552 env[1618]: time="2024-12-13T14:14:27.122524186Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Dec 13 14:14:27.122675 env[1618]: time="2024-12-13T14:14:27.122645615Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Dec 13 14:14:27.122866 env[1618]: time="2024-12-13T14:14:27.122837959Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Dec 13 14:14:27.123359 env[1618]: time="2024-12-13T14:14:27.123263060Z" 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:14:27.138697 env[1618]: time="2024-12-13T14:14:27.138646199Z" level=info msg="Connect containerd service" Dec 13 14:14:27.138989 env[1618]: time="2024-12-13T14:14:27.138955419Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Dec 13 14:14:27.144241 env[1618]: time="2024-12-13T14:14:27.144130157Z" 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:14:27.144634 env[1618]: time="2024-12-13T14:14:27.144554181Z" level=info msg="Start subscribing containerd event" Dec 13 14:14:27.144714 env[1618]: time="2024-12-13T14:14:27.144653846Z" level=info msg="Start recovering state" Dec 13 14:14:27.144852 env[1618]: time="2024-12-13T14:14:27.144767317Z" level=info msg="Start event monitor" Dec 13 14:14:27.144918 env[1618]: time="2024-12-13T14:14:27.144864410Z" level=info msg="Start snapshots syncer" Dec 13 14:14:27.144918 env[1618]: time="2024-12-13T14:14:27.144890890Z" level=info msg="Start cni network conf syncer for default" Dec 13 14:14:27.145018 env[1618]: time="2024-12-13T14:14:27.144915655Z" level=info msg="Start streaming server" Dec 13 14:14:27.145343 env[1618]: time="2024-12-13T14:14:27.145307883Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 13 14:14:27.151120 env[1618]: time="2024-12-13T14:14:27.151055666Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 13 14:14:27.157566 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:14:27.160027 env[1618]: time="2024-12-13T14:14:27.159924961Z" level=info msg="containerd successfully booted in 0.340792s" Dec 13 14:14:27.373044 coreos-metadata[1604]: Dec 13 14:14:27.372 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Dec 13 14:14:27.381327 systemd[1]: Started containerd.service. Dec 13 14:14:27.383931 systemd[1]: Finished systemd-networkd-wait-online.service. Dec 13 14:14:27.386961 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 13 14:14:27.387423 systemd[1]: Finished extend-filesystems.service. Dec 13 14:14:27.394720 coreos-metadata[1604]: Dec 13 14:14:27.394 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys: Attempt #1 Dec 13 14:14:27.390574 systemd[1]: motdgen.service: Deactivated successfully. Dec 13 14:14:27.390947 systemd[1]: Finished motdgen.service. Dec 13 14:14:27.397699 coreos-metadata[1604]: Dec 13 14:14:27.397 INFO Fetch successful Dec 13 14:14:27.397699 coreos-metadata[1604]: Dec 13 14:14:27.397 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys/0/openssh-key: Attempt #1 Dec 13 14:14:27.404120 coreos-metadata[1604]: Dec 13 14:14:27.400 INFO Fetch successful Dec 13 14:14:27.415559 unknown[1604]: wrote ssh authorized keys file for user: core Dec 13 14:14:27.437966 systemd[1]: Started update-engine.service. Dec 13 14:14:27.440706 systemd[1]: Started systemd-logind.service. Dec 13 14:14:27.445710 systemd[1]: Reached target network-online.target. Dec 13 14:14:27.452451 systemd[1]: Started amazon-ssm-agent.service. Dec 13 14:14:27.467402 systemd[1]: Started locksmithd.service. Dec 13 14:14:27.487826 systemd[1]: Started nvidia.service. Dec 13 14:14:27.499766 systemd[1]: Starting oem-cloudinit.service... Dec 13 14:14:27.505213 systemd[1]: Starting systemd-hostnamed.service... Dec 13 14:14:27.530767 bash[1812]: + OEMS=(aws gcp rackspace-onmetal azure cloudsigma packet vmware digitalocean openstack) Dec 13 14:14:27.532396 bash[1815]: + echo aws gcp rackspace-onmetal azure cloudsigma packet vmware digitalocean openstack Dec 13 14:14:27.533183 bash[1816]: + tr ' ' ' Dec 13 14:14:27.534415 bash[1817]: + grep -q -x -F aws Dec 13 14:14:27.535923 bash[1816]: ' Dec 13 14:14:27.550493 update-ssh-keys[1808]: Updated "/home/core/.ssh/authorized_keys" Dec 13 14:14:27.551117 systemd[1]: Finished coreos-metadata-sshkeys@core.service. Dec 13 14:14:27.602732 bash[1823]: ++ '[' aws = aws -o aws = openstack ']' Dec 13 14:14:27.602732 bash[1823]: ++ echo ec2-compat Dec 13 14:14:27.603338 bash[1819]: + /usr/bin/coreos-cloudinit --oem=ec2-compat Dec 13 14:14:27.784246 amazon-ssm-agent[1809]: 2024/12/13 14:14:27 Failed to load instance info from vault. RegistrationKey does not exist. Dec 13 14:14:27.787366 amazon-ssm-agent[1809]: Initializing new seelog logger Dec 13 14:14:27.797024 amazon-ssm-agent[1809]: New Seelog Logger Creation Complete Dec 13 14:14:27.797436 amazon-ssm-agent[1809]: 2024/12/13 14:14:27 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Dec 13 14:14:27.797633 amazon-ssm-agent[1809]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Dec 13 14:14:27.798159 amazon-ssm-agent[1809]: 2024/12/13 14:14:27 processing appconfig overrides Dec 13 14:14:27.875041 systemd[1]: nvidia.service: Deactivated successfully. Dec 13 14:14:27.888565 dbus-daemon[1605]: [system] Successfully activated service 'org.freedesktop.hostname1' Dec 13 14:14:27.888809 systemd[1]: Started systemd-hostnamed.service. Dec 13 14:14:27.891855 dbus-daemon[1605]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1813 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Dec 13 14:14:27.898923 systemd[1]: Starting polkit.service... Dec 13 14:14:27.911175 bash[1819]: 2024/12/13 14:14:27 fetching token... Dec 13 14:14:27.916971 bash[1819]: 2024/12/13 14:14:27 Checking availability of "cloud-drive" Dec 13 14:14:27.916971 bash[1819]: 2024/12/13 14:14:27 Checking availability of "ec2-metadata-service" Dec 13 14:14:27.918739 bash[1819]: 2024/12/13 14:14:27 Fetching user-data from datasource of type "ec2-metadata-service" Dec 13 14:14:27.918739 bash[1819]: 2024/12/13 14:14:27 Fetching data from http://169.254.169.254/2009-04-04/user-data. Attempt #1 Dec 13 14:14:27.921597 bash[1819]: 2024/12/13 14:14:27 Fetching meta-data from datasource of type "ec2-metadata-service" Dec 13 14:14:27.921597 bash[1819]: 2024/12/13 14:14:27 Fetching data from http://169.254.169.254/2009-04-04/meta-data/public-keys. Attempt #1 Dec 13 14:14:27.922683 bash[1819]: 2024/12/13 14:14:27 Fetching data from http://169.254.169.254/2009-04-04/meta-data/public-keys/0/openssh-key. Attempt #1 Dec 13 14:14:27.925175 bash[1819]: 2024/12/13 14:14:27 Found SSH key for "ci-3510.3.6-arm64-374b57dc-0d90-4adc-8803-8957ab5d71b1" Dec 13 14:14:27.925175 bash[1819]: 2024/12/13 14:14:27 Fetching data from http://169.254.169.254/2009-04-04/meta-data/hostname. Attempt #1 Dec 13 14:14:27.926399 bash[1819]: 2024/12/13 14:14:27 Fetching data from http://169.254.169.254/2009-04-04/meta-data/local-ipv4. Attempt #1 Dec 13 14:14:27.927362 bash[1819]: 2024/12/13 14:14:27 Fetching data from http://169.254.169.254/2009-04-04/meta-data/public-ipv4. Attempt #1 Dec 13 14:14:27.928459 bash[1819]: 2024/12/13 14:14:27 Merging cloud-config from meta-data and user-data Dec 13 14:14:27.943333 polkitd[1851]: Started polkitd version 121 Dec 13 14:14:27.957054 systemd-hostnamed[1813]: Hostname set to (static) Dec 13 14:14:27.957160 systemd-resolved[1578]: System hostname changed to 'ip-172-31-18-236.us-west-2.compute.internal'. Dec 13 14:14:27.962998 bash[1819]: 2024/12/13 14:14:27 Set hostname to ip-172-31-18-236.us-west-2.compute.internal Dec 13 14:14:27.969851 polkitd[1851]: Loading rules from directory /etc/polkit-1/rules.d Dec 13 14:14:27.970109 polkitd[1851]: Loading rules from directory /usr/share/polkit-1/rules.d Dec 13 14:14:27.972297 polkitd[1851]: Finished loading, compiling and executing 2 rules Dec 13 14:14:27.974057 dbus-daemon[1605]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Dec 13 14:14:27.974513 systemd[1]: Started polkit.service. Dec 13 14:14:27.978212 polkitd[1851]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Dec 13 14:14:27.983633 bash[1819]: 2024/12/13 14:14:27 Authorized SSH keys for core user Dec 13 14:14:27.983633 bash[1819]: 2024/12/13 14:14:27 Writing file to "/etc/environment" Dec 13 14:14:27.983633 bash[1819]: 2024/12/13 14:14:27 Wrote file to "/etc/environment" Dec 13 14:14:27.983633 bash[1819]: 2024/12/13 14:14:27 Updated /etc/environment Dec 13 14:14:27.983633 bash[1819]: 2024/12/13 14:14:27 Ensuring runtime unit file "etcd.service" is unmasked Dec 13 14:14:27.983633 bash[1819]: 2024/12/13 14:14:27 Ensuring runtime unit file "etcd2.service" is unmasked Dec 13 14:14:27.983633 bash[1819]: 2024/12/13 14:14:27 Ensuring runtime unit file "fleet.service" is unmasked Dec 13 14:14:27.983633 bash[1819]: 2024/12/13 14:14:27 Ensuring runtime unit file "locksmithd.service" is unmasked Dec 13 14:14:27.988094 systemd[1]: oem-cloudinit.service: Deactivated successfully. Dec 13 14:14:27.988425 systemd[1]: Finished oem-cloudinit.service. Dec 13 14:14:27.992285 systemd[1]: Finished enable-oem-cloudinit.service. Dec 13 14:14:28.154109 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Create new startup processor Dec 13 14:14:28.156376 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [LongRunningPluginsManager] registered plugins: {} Dec 13 14:14:28.156520 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Initializing bookkeeping folders Dec 13 14:14:28.156520 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO removing the completed state files Dec 13 14:14:28.156520 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Initializing bookkeeping folders for long running plugins Dec 13 14:14:28.156520 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Initializing replies folder for MDS reply requests that couldn't reach the service Dec 13 14:14:28.156734 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Initializing healthcheck folders for long running plugins Dec 13 14:14:28.156734 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Initializing locations for inventory plugin Dec 13 14:14:28.156734 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Initializing default location for custom inventory Dec 13 14:14:28.156734 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Initializing default location for file inventory Dec 13 14:14:28.156734 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Initializing default location for role inventory Dec 13 14:14:28.156734 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Init the cloudwatchlogs publisher Dec 13 14:14:28.156734 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Successfully loaded platform independent plugin aws:runDockerAction Dec 13 14:14:28.156734 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Successfully loaded platform independent plugin aws:refreshAssociation Dec 13 14:14:28.157186 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Successfully loaded platform independent plugin aws:configurePackage Dec 13 14:14:28.157186 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Successfully loaded platform independent plugin aws:downloadContent Dec 13 14:14:28.157186 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Successfully loaded platform independent plugin aws:runDocument Dec 13 14:14:28.157186 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Successfully loaded platform independent plugin aws:softwareInventory Dec 13 14:14:28.157186 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Successfully loaded platform independent plugin aws:runPowerShellScript Dec 13 14:14:28.157186 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Successfully loaded platform independent plugin aws:updateSsmAgent Dec 13 14:14:28.157186 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Successfully loaded platform independent plugin aws:configureDocker Dec 13 14:14:28.157186 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Successfully loaded platform dependent plugin aws:runShellScript Dec 13 14:14:28.157186 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO Starting Agent: amazon-ssm-agent - v2.3.1319.0 Dec 13 14:14:28.157186 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO OS: linux, Arch: arm64 Dec 13 14:14:28.167389 amazon-ssm-agent[1809]: datastore file /var/lib/amazon/ssm/i-000e564b1f9502f96/longrunningplugins/datastore/store doesn't exist - no long running plugins to execute Dec 13 14:14:28.254774 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessagingDeliveryService] Starting document processing engine... Dec 13 14:14:28.267651 locksmithd[1810]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 13 14:14:28.349001 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessagingDeliveryService] [EngineProcessor] Starting Dec 13 14:14:28.443338 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessagingDeliveryService] [EngineProcessor] Initial processing Dec 13 14:14:28.537991 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessageGatewayService] Starting session document processing engine... Dec 13 14:14:28.632774 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessageGatewayService] [EngineProcessor] Starting Dec 13 14:14:28.727720 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessageGatewayService] SSM Agent is trying to setup control channel for Session Manager module. Dec 13 14:14:28.822718 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [OfflineService] Starting document processing engine... Dec 13 14:14:28.918039 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessageGatewayService] listening reply. Dec 13 14:14:29.013656 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [OfflineService] [EngineProcessor] Starting Dec 13 14:14:29.109313 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [OfflineService] [EngineProcessor] Initial processing Dec 13 14:14:29.205237 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [StartupProcessor] Executing startup processor tasks Dec 13 14:14:29.301512 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [StartupProcessor] Write to serial port: Amazon SSM Agent v2.3.1319.0 is running Dec 13 14:14:29.397759 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [StartupProcessor] Write to serial port: OsProductName: Flatcar Container Linux by Kinvolk Dec 13 14:14:29.494294 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessageGatewayService] Setting up websocket for controlchannel for instance: i-000e564b1f9502f96, requestId: 348c4fff-ef62-4678-91ac-98efbb28b2e7 Dec 13 14:14:29.591050 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [LongRunningPluginsManager] starting long running plugin manager Dec 13 14:14:29.687761 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [LongRunningPluginsManager] there aren't any long running plugin to execute Dec 13 14:14:29.784923 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [LongRunningPluginsManager] There are no long running plugins currently getting executed - skipping their healthcheck Dec 13 14:14:29.882414 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [OfflineService] Starting message polling Dec 13 14:14:29.980301 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [OfflineService] Starting send replies to MDS Dec 13 14:14:30.077939 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [HealthCheck] HealthCheck reporting agent health. Dec 13 14:14:30.175958 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessagingDeliveryService] Starting message polling Dec 13 14:14:30.274165 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessagingDeliveryService] Starting send replies to MDS Dec 13 14:14:30.372456 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [instanceID=i-000e564b1f9502f96] Starting association polling Dec 13 14:14:30.470883 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessagingDeliveryService] [Association] [EngineProcessor] Starting Dec 13 14:14:30.569462 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessagingDeliveryService] [Association] Launching response handler Dec 13 14:14:30.668335 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessagingDeliveryService] [Association] [EngineProcessor] Initial processing Dec 13 14:14:30.767523 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessagingDeliveryService] [Association] Initializing association scheduling service Dec 13 14:14:30.866720 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessagingDeliveryService] [Association] Association scheduling service initialized Dec 13 14:14:30.966196 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [StartupProcessor] Write to serial port: OsVersion: 3510.3.6 Dec 13 14:14:31.066333 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessageGatewayService] Opening websocket connection to: wss://ssmmessages.us-west-2.amazonaws.com/v1/control-channel/i-000e564b1f9502f96?role=subscribe&stream=input Dec 13 14:14:31.166164 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessageGatewayService] Successfully opened websocket connection to: wss://ssmmessages.us-west-2.amazonaws.com/v1/control-channel/i-000e564b1f9502f96?role=subscribe&stream=input Dec 13 14:14:31.266181 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessageGatewayService] Starting receiving message from control channel Dec 13 14:14:31.366468 amazon-ssm-agent[1809]: 2024-12-13 14:14:28 INFO [MessageGatewayService] [EngineProcessor] Initial processing Dec 13 14:14:31.466938 amazon-ssm-agent[1809]: 2024-12-13 14:14:29 INFO [MessagingDeliveryService] [Association] No associations on boot. Requerying for associations after 30 seconds. Dec 13 14:14:31.928115 sshd_keygen[1631]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Dec 13 14:14:31.967411 systemd[1]: Finished sshd-keygen.service. Dec 13 14:14:31.973106 systemd[1]: Starting issuegen.service... Dec 13 14:14:31.985558 systemd[1]: issuegen.service: Deactivated successfully. Dec 13 14:14:31.986104 systemd[1]: Finished issuegen.service. Dec 13 14:14:31.991223 systemd[1]: Starting systemd-user-sessions.service... Dec 13 14:14:32.007047 systemd[1]: Finished systemd-user-sessions.service. Dec 13 14:14:32.011609 systemd[1]: Started getty@tty1.service. Dec 13 14:14:32.016137 systemd[1]: Started serial-getty@ttyS0.service. Dec 13 14:14:32.018220 systemd[1]: Reached target getty.target. Dec 13 14:14:32.020128 systemd[1]: Reached target multi-user.target. Dec 13 14:14:32.024667 systemd[1]: Starting systemd-update-utmp-runlevel.service... Dec 13 14:14:32.042399 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Dec 13 14:14:32.042861 systemd[1]: Finished systemd-update-utmp-runlevel.service. Dec 13 14:14:32.045011 systemd[1]: Startup finished in 1.178s (kernel) + 7.246s (initrd) + 14.205s (userspace) = 22.631s. Dec 13 14:14:34.712983 systemd[1]: Created slice system-sshd.slice. Dec 13 14:14:34.715412 systemd[1]: Started sshd@0-172.31.18.236:22-139.178.89.65:37712.service. Dec 13 14:14:34.903722 sshd[1882]: Accepted publickey for core from 139.178.89.65 port 37712 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:14:34.909200 sshd[1882]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:14:34.933599 systemd[1]: Created slice user-500.slice. Dec 13 14:14:34.936415 systemd[1]: Starting user-runtime-dir@500.service... Dec 13 14:14:34.943690 systemd-logind[1612]: New session 1 of user core. Dec 13 14:14:34.956570 systemd[1]: Finished user-runtime-dir@500.service. Dec 13 14:14:34.960845 systemd[1]: Starting user@500.service... Dec 13 14:14:34.968510 (systemd)[1885]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:14:35.157250 systemd[1885]: Queued start job for default target default.target. Dec 13 14:14:35.158307 systemd[1885]: Reached target paths.target. Dec 13 14:14:35.158359 systemd[1885]: Reached target sockets.target. Dec 13 14:14:35.158393 systemd[1885]: Reached target timers.target. Dec 13 14:14:35.158423 systemd[1885]: Reached target basic.target. Dec 13 14:14:35.158518 systemd[1885]: Reached target default.target. Dec 13 14:14:35.158605 systemd[1885]: Startup finished in 178ms. Dec 13 14:14:35.158922 systemd[1]: Started user@500.service. Dec 13 14:14:35.160958 systemd[1]: Started session-1.scope. Dec 13 14:14:35.306178 systemd[1]: Started sshd@1-172.31.18.236:22-139.178.89.65:37728.service. Dec 13 14:14:35.478658 sshd[1894]: Accepted publickey for core from 139.178.89.65 port 37728 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:14:35.481160 sshd[1894]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:14:35.488365 systemd-logind[1612]: New session 2 of user core. Dec 13 14:14:35.490244 systemd[1]: Started session-2.scope. Dec 13 14:14:35.617058 sshd[1894]: pam_unix(sshd:session): session closed for user core Dec 13 14:14:35.622832 systemd-logind[1612]: Session 2 logged out. Waiting for processes to exit. Dec 13 14:14:35.623355 systemd[1]: session-2.scope: Deactivated successfully. Dec 13 14:14:35.624628 systemd[1]: sshd@1-172.31.18.236:22-139.178.89.65:37728.service: Deactivated successfully. Dec 13 14:14:35.626180 systemd-logind[1612]: Removed session 2. Dec 13 14:14:35.647958 systemd[1]: Started sshd@2-172.31.18.236:22-139.178.89.65:37740.service. Dec 13 14:14:35.822057 sshd[1900]: Accepted publickey for core from 139.178.89.65 port 37740 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:14:35.824800 sshd[1900]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:14:35.835071 systemd[1]: Started session-3.scope. Dec 13 14:14:35.836033 systemd-logind[1612]: New session 3 of user core. Dec 13 14:14:35.961202 sshd[1900]: pam_unix(sshd:session): session closed for user core Dec 13 14:14:35.966592 systemd[1]: sshd@2-172.31.18.236:22-139.178.89.65:37740.service: Deactivated successfully. Dec 13 14:14:35.968111 systemd[1]: session-3.scope: Deactivated successfully. Dec 13 14:14:35.969610 systemd-logind[1612]: Session 3 logged out. Waiting for processes to exit. Dec 13 14:14:35.971700 systemd-logind[1612]: Removed session 3. Dec 13 14:14:35.989459 systemd[1]: Started sshd@3-172.31.18.236:22-139.178.89.65:37748.service. Dec 13 14:14:36.163622 sshd[1906]: Accepted publickey for core from 139.178.89.65 port 37748 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:14:36.167017 sshd[1906]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:14:36.176127 systemd-logind[1612]: New session 4 of user core. Dec 13 14:14:36.176610 systemd[1]: Started session-4.scope. Dec 13 14:14:36.312311 sshd[1906]: pam_unix(sshd:session): session closed for user core Dec 13 14:14:36.318241 systemd-logind[1612]: Session 4 logged out. Waiting for processes to exit. Dec 13 14:14:36.318806 systemd[1]: session-4.scope: Deactivated successfully. Dec 13 14:14:36.319896 systemd[1]: sshd@3-172.31.18.236:22-139.178.89.65:37748.service: Deactivated successfully. Dec 13 14:14:36.322012 systemd-logind[1612]: Removed session 4. Dec 13 14:14:36.342972 systemd[1]: Started sshd@4-172.31.18.236:22-139.178.89.65:37758.service. Dec 13 14:14:36.515736 sshd[1912]: Accepted publickey for core from 139.178.89.65 port 37758 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:14:36.518136 sshd[1912]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:14:36.526596 systemd[1]: Started session-5.scope. Dec 13 14:14:36.527406 systemd-logind[1612]: New session 5 of user core. Dec 13 14:14:36.650812 sudo[1915]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Dec 13 14:14:36.652461 sudo[1915]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 13 14:14:36.667122 dbus-daemon[1605]: avc: received setenforce notice (enforcing=1) Dec 13 14:14:36.670949 sudo[1915]: pam_unix(sudo:session): session closed for user root Dec 13 14:14:36.696359 sshd[1912]: pam_unix(sshd:session): session closed for user core Dec 13 14:14:36.703221 systemd[1]: sshd@4-172.31.18.236:22-139.178.89.65:37758.service: Deactivated successfully. Dec 13 14:14:36.704932 systemd[1]: session-5.scope: Deactivated successfully. Dec 13 14:14:36.706177 systemd-logind[1612]: Session 5 logged out. Waiting for processes to exit. Dec 13 14:14:36.708162 systemd-logind[1612]: Removed session 5. Dec 13 14:14:36.727273 systemd[1]: Started sshd@5-172.31.18.236:22-139.178.89.65:37760.service. Dec 13 14:14:36.907470 sshd[1920]: Accepted publickey for core from 139.178.89.65 port 37760 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:14:36.909843 sshd[1920]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:14:36.917847 systemd-logind[1612]: New session 6 of user core. Dec 13 14:14:36.918717 systemd[1]: Started session-6.scope. Dec 13 14:14:37.027900 sudo[1924]: 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:14:37.028554 sudo[1924]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 13 14:14:37.034732 sudo[1924]: pam_unix(sudo:session): session closed for user root Dec 13 14:14:37.045179 sudo[1923]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Dec 13 14:14:37.046432 sudo[1923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 13 14:14:37.066235 systemd[1]: Stopping audit-rules.service... Dec 13 14:14:37.067000 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:14:37.070370 kernel: kauditd_printk_skb: 66 callbacks suppressed Dec 13 14:14:37.070479 kernel: audit: type=1305 audit(1734099277.067:158): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Dec 13 14:14:37.075294 auditctl[1927]: No rules Dec 13 14:14:37.067000 audit[1927]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe83de5c0 a2=420 a3=0 items=0 ppid=1 pid=1927 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:14:37.076650 systemd[1]: audit-rules.service: Deactivated successfully. Dec 13 14:14:37.077016 systemd[1]: Stopped audit-rules.service. Dec 13 14:14:37.085732 kernel: audit: type=1300 audit(1734099277.067:158): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe83de5c0 a2=420 a3=0 items=0 ppid=1 pid=1927 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:14:37.087657 systemd[1]: Starting audit-rules.service... Dec 13 14:14:37.067000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Dec 13 14:14:37.074000 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:14:37.100692 kernel: audit: type=1327 audit(1734099277.067:158): proctitle=2F7362696E2F617564697463746C002D44 Dec 13 14:14:37.100840 kernel: audit: type=1131 audit(1734099277.074:159): 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:14:37.121036 augenrules[1944]: No rules Dec 13 14:14:37.122798 systemd[1]: Finished audit-rules.service. Dec 13 14:14:37.121000 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:14:37.125214 sudo[1923]: pam_unix(sudo:session): session closed for user root Dec 13 14:14:37.122000 audit[1923]: USER_END pid=1923 uid=500 auid=500 ses=6 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:14:37.140432 kernel: audit: type=1130 audit(1734099277.121:160): 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:14:37.140526 kernel: audit: type=1106 audit(1734099277.122:161): pid=1923 uid=500 auid=500 ses=6 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:14:37.140586 kernel: audit: type=1104 audit(1734099277.122:162): pid=1923 uid=500 auid=500 ses=6 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:14:37.122000 audit[1923]: CRED_DISP pid=1923 uid=500 auid=500 ses=6 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:14:37.155114 sshd[1920]: pam_unix(sshd:session): session closed for user core Dec 13 14:14:37.156000 audit[1920]: USER_END pid=1920 uid=0 auid=500 ses=6 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:14:37.160184 systemd[1]: session-6.scope: Deactivated successfully. Dec 13 14:14:37.161396 systemd[1]: sshd@5-172.31.18.236:22-139.178.89.65:37760.service: Deactivated successfully. Dec 13 14:14:37.166917 systemd-logind[1612]: Session 6 logged out. Waiting for processes to exit. Dec 13 14:14:37.156000 audit[1920]: CRED_DISP pid=1920 uid=0 auid=500 ses=6 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:14:37.169738 systemd-logind[1612]: Removed session 6. Dec 13 14:14:37.177263 kernel: audit: type=1106 audit(1734099277.156:163): pid=1920 uid=0 auid=500 ses=6 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:14:37.184733 kernel: audit: type=1104 audit(1734099277.156:164): pid=1920 uid=0 auid=500 ses=6 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:14:37.184840 kernel: audit: type=1131 audit(1734099277.156:165): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-172.31.18.236:22-139.178.89.65:37760 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:14:37.156000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-172.31.18.236:22-139.178.89.65:37760 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:14:37.187183 systemd[1]: Started sshd@6-172.31.18.236:22-139.178.89.65:37762.service. Dec 13 14:14:37.186000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-172.31.18.236:22-139.178.89.65:37762 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:14:37.364000 audit[1950]: USER_ACCT pid=1950 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:14:37.365101 sshd[1950]: Accepted publickey for core from 139.178.89.65 port 37762 ssh2: RSA SHA256:07jB2DPJgjjhgg3L8Uh349EZ0zHZFrUiRWNbK+Fdo0Q Dec 13 14:14:37.365000 audit[1950]: CRED_ACQ pid=1950 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:14:37.366000 audit[1950]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffcb1e3270 a2=3 a3=1 items=0 ppid=1 pid=1950 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=7 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 13 14:14:37.366000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Dec 13 14:14:37.367977 sshd[1950]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Dec 13 14:14:37.376413 systemd[1]: Started session-7.scope. Dec 13 14:14:37.377316 systemd-logind[1612]: New session 7 of user core. Dec 13 14:14:37.385000 audit[1950]: USER_START pid=1950 uid=0 auid=500 ses=7 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:14:37.388000 audit[1952]: CRED_ACQ pid=1952 uid=0 auid=500 ses=7 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:14:37.483000 audit[1955]: USER_ACCT pid=1955 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Dec 13 14:14:37.484863 sudo[1955]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/tee /etc/flatcar/update.conf Dec 13 14:14:37.484000 audit[1955]: CRED_REFR pid=1955 uid=500 auid=500 ses=7 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:14:37.485405 sudo[1955]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Dec 13 14:14:37.487000 audit[1955]: USER_START pid=1955 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open 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:14:37.493331 sudo[1955]: pam_unix(sudo:session): session closed for user root Dec 13 14:14:37.492000 audit[1955]: USER_END pid=1955 uid=500 auid=500 ses=7 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:14:37.492000 audit[1955]: CRED_DISP pid=1955 uid=500 auid=500 ses=7 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:14:37.500826 systemd[1]: Starting motdgen.service... Dec 13 14:14:37.516884 systemd[1]: motdgen.service: Deactivated successfully. Dec 13 14:14:37.517231 systemd[1]: Finished motdgen.service. Dec 13 14:14:37.518665 sshd[1950]: pam_unix(sshd:session): session closed for user core Dec 13 14:14:37.516000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=motdgen comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:14:37.516000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=motdgen comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:14:37.521000 audit[1950]: USER_END pid=1950 uid=0 auid=500 ses=7 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:14:37.521000 audit[1950]: CRED_DISP pid=1950 uid=0 auid=500 ses=7 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:14:37.524544 systemd[1]: sshd@6-172.31.18.236:22-139.178.89.65:37762.service: Deactivated successfully. Dec 13 14:14:37.525915 systemd[1]: session-7.scope: Deactivated successfully. Dec 13 14:14:37.524000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-172.31.18.236:22-139.178.89.65:37762 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 13 14:14:37.527370 systemd-logind[1612]: Session 7 logged out. Waiting for processes to exit. Dec 13 14:14:37.529279 systemd-logind[1612]: Removed session 7.