Sep 13 00:03:09.025772 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Sep 13 00:03:09.025812 kernel: Linux version 5.15.192-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 Sep 12 23:05:37 -00 2025 Sep 13 00:03:09.025835 kernel: efi: EFI v2.70 by EDK II Sep 13 00:03:09.025850 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7affea98 MEMRESERVE=0x716fcf98 Sep 13 00:03:09.025864 kernel: ACPI: Early table checksum verification disabled Sep 13 00:03:09.025878 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Sep 13 00:03:09.025894 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Sep 13 00:03:09.025908 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Sep 13 00:03:09.025922 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Sep 13 00:03:09.025936 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Sep 13 00:03:09.025954 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Sep 13 00:03:09.025968 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Sep 13 00:03:09.025982 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Sep 13 00:03:09.025996 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Sep 13 00:03:09.026013 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Sep 13 00:03:09.026032 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Sep 13 00:03:09.026047 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Sep 13 00:03:09.026061 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Sep 13 00:03:09.026075 kernel: printk: bootconsole [uart0] enabled Sep 13 00:03:09.026089 kernel: NUMA: Failed to initialise from firmware Sep 13 00:03:09.026104 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Sep 13 00:03:09.026119 kernel: NUMA: NODE_DATA [mem 0x4b5843900-0x4b5848fff] Sep 13 00:03:09.026133 kernel: Zone ranges: Sep 13 00:03:09.026148 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Sep 13 00:03:09.026162 kernel: DMA32 empty Sep 13 00:03:09.026177 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Sep 13 00:03:09.026195 kernel: Movable zone start for each node Sep 13 00:03:09.026214 kernel: Early memory node ranges Sep 13 00:03:09.026228 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Sep 13 00:03:09.026243 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Sep 13 00:03:09.026258 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Sep 13 00:03:09.026272 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Sep 13 00:03:09.026287 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Sep 13 00:03:09.026301 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Sep 13 00:03:09.026315 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Sep 13 00:03:09.026330 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Sep 13 00:03:09.026344 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Sep 13 00:03:09.026359 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Sep 13 00:03:09.038446 kernel: psci: probing for conduit method from ACPI. Sep 13 00:03:09.038467 kernel: psci: PSCIv1.0 detected in firmware. Sep 13 00:03:09.038498 kernel: psci: Using standard PSCI v0.2 function IDs Sep 13 00:03:09.038514 kernel: psci: Trusted OS migration not required Sep 13 00:03:09.038530 kernel: psci: SMC Calling Convention v1.1 Sep 13 00:03:09.038550 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Sep 13 00:03:09.038566 kernel: ACPI: SRAT not present Sep 13 00:03:09.038583 kernel: percpu: Embedded 30 pages/cpu s83032 r8192 d31656 u122880 Sep 13 00:03:09.038599 kernel: pcpu-alloc: s83032 r8192 d31656 u122880 alloc=30*4096 Sep 13 00:03:09.038615 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 13 00:03:09.038631 kernel: Detected PIPT I-cache on CPU0 Sep 13 00:03:09.038646 kernel: CPU features: detected: GIC system register CPU interface Sep 13 00:03:09.038662 kernel: CPU features: detected: Spectre-v2 Sep 13 00:03:09.038677 kernel: CPU features: detected: Spectre-v3a Sep 13 00:03:09.038692 kernel: CPU features: detected: Spectre-BHB Sep 13 00:03:09.038708 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 13 00:03:09.038728 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 13 00:03:09.038744 kernel: CPU features: detected: ARM erratum 1742098 Sep 13 00:03:09.038759 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Sep 13 00:03:09.038774 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Sep 13 00:03:09.038789 kernel: Policy zone: Normal Sep 13 00:03:09.038808 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=563df7b8a9b19b8c496587ae06f3c3ec1604a5105c3a3f313c9ccaa21d8055ca Sep 13 00:03:09.038825 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 13 00:03:09.038840 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 13 00:03:09.038855 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 13 00:03:09.038870 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 13 00:03:09.038890 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Sep 13 00:03:09.038907 kernel: Memory: 3824460K/4030464K available (9792K kernel code, 2094K rwdata, 7592K rodata, 36416K init, 777K bss, 206004K reserved, 0K cma-reserved) Sep 13 00:03:09.038924 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 13 00:03:09.038939 kernel: trace event string verifier disabled Sep 13 00:03:09.038954 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 13 00:03:09.038970 kernel: rcu: RCU event tracing is enabled. Sep 13 00:03:09.038987 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 13 00:03:09.039002 kernel: Trampoline variant of Tasks RCU enabled. Sep 13 00:03:09.039018 kernel: Tracing variant of Tasks RCU enabled. Sep 13 00:03:09.039034 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 13 00:03:09.039049 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 13 00:03:09.039064 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 13 00:03:09.039084 kernel: GICv3: 96 SPIs implemented Sep 13 00:03:09.039099 kernel: GICv3: 0 Extended SPIs implemented Sep 13 00:03:09.039115 kernel: GICv3: Distributor has no Range Selector support Sep 13 00:03:09.039130 kernel: Root IRQ handler: gic_handle_irq Sep 13 00:03:09.039145 kernel: GICv3: 16 PPIs implemented Sep 13 00:03:09.039160 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Sep 13 00:03:09.039176 kernel: ACPI: SRAT not present Sep 13 00:03:09.039190 kernel: ITS [mem 0x10080000-0x1009ffff] Sep 13 00:03:09.039205 kernel: ITS@0x0000000010080000: allocated 8192 Devices @400090000 (indirect, esz 8, psz 64K, shr 1) Sep 13 00:03:09.039221 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000a0000 (flat, esz 8, psz 64K, shr 1) Sep 13 00:03:09.039236 kernel: GICv3: using LPI property table @0x00000004000b0000 Sep 13 00:03:09.039255 kernel: ITS: Using hypervisor restricted LPI range [128] Sep 13 00:03:09.039271 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000d0000 Sep 13 00:03:09.039286 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Sep 13 00:03:09.039301 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Sep 13 00:03:09.039317 kernel: sched_clock: 56 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Sep 13 00:03:09.039332 kernel: Console: colour dummy device 80x25 Sep 13 00:03:09.039348 kernel: printk: console [tty1] enabled Sep 13 00:03:09.039363 kernel: ACPI: Core revision 20210730 Sep 13 00:03:09.039409 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Sep 13 00:03:09.039427 kernel: pid_max: default: 32768 minimum: 301 Sep 13 00:03:09.039448 kernel: LSM: Security Framework initializing Sep 13 00:03:09.039463 kernel: SELinux: Initializing. Sep 13 00:03:09.039479 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 13 00:03:09.039495 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 13 00:03:09.039511 kernel: rcu: Hierarchical SRCU implementation. Sep 13 00:03:09.039527 kernel: Platform MSI: ITS@0x10080000 domain created Sep 13 00:03:09.039542 kernel: PCI/MSI: ITS@0x10080000 domain created Sep 13 00:03:09.039558 kernel: Remapping and enabling EFI services. Sep 13 00:03:09.039573 kernel: smp: Bringing up secondary CPUs ... Sep 13 00:03:09.039589 kernel: Detected PIPT I-cache on CPU1 Sep 13 00:03:09.039609 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Sep 13 00:03:09.039625 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000e0000 Sep 13 00:03:09.039641 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Sep 13 00:03:09.039657 kernel: smp: Brought up 1 node, 2 CPUs Sep 13 00:03:09.039672 kernel: SMP: Total of 2 processors activated. Sep 13 00:03:09.039688 kernel: CPU features: detected: 32-bit EL0 Support Sep 13 00:03:09.039703 kernel: CPU features: detected: 32-bit EL1 Support Sep 13 00:03:09.039719 kernel: CPU features: detected: CRC32 instructions Sep 13 00:03:09.039735 kernel: CPU: All CPU(s) started at EL1 Sep 13 00:03:09.039755 kernel: alternatives: patching kernel code Sep 13 00:03:09.039770 kernel: devtmpfs: initialized Sep 13 00:03:09.039796 kernel: KASLR disabled due to lack of seed Sep 13 00:03:09.039816 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 13 00:03:09.039833 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Sep 13 00:03:09.039849 kernel: pinctrl core: initialized pinctrl subsystem Sep 13 00:03:09.039865 kernel: SMBIOS 3.0.0 present. Sep 13 00:03:09.039881 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Sep 13 00:03:09.039897 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 13 00:03:09.039914 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 13 00:03:09.039930 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 13 00:03:09.039951 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 13 00:03:09.039967 kernel: audit: initializing netlink subsys (disabled) Sep 13 00:03:09.039983 kernel: audit: type=2000 audit(0.380:1): state=initialized audit_enabled=0 res=1 Sep 13 00:03:09.039999 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 13 00:03:09.040016 kernel: cpuidle: using governor menu Sep 13 00:03:09.040036 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 13 00:03:09.040053 kernel: ASID allocator initialised with 32768 entries Sep 13 00:03:09.040069 kernel: ACPI: bus type PCI registered Sep 13 00:03:09.040085 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 13 00:03:09.040101 kernel: Serial: AMBA PL011 UART driver Sep 13 00:03:09.040117 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Sep 13 00:03:09.040134 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Sep 13 00:03:09.040150 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Sep 13 00:03:09.040166 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Sep 13 00:03:09.040186 kernel: cryptd: max_cpu_qlen set to 1000 Sep 13 00:03:09.040202 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 13 00:03:09.040218 kernel: ACPI: Added _OSI(Module Device) Sep 13 00:03:09.040234 kernel: ACPI: Added _OSI(Processor Device) Sep 13 00:03:09.040250 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 13 00:03:09.040267 kernel: ACPI: Added _OSI(Linux-Dell-Video) Sep 13 00:03:09.040283 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Sep 13 00:03:09.040299 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Sep 13 00:03:09.040315 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 13 00:03:09.040331 kernel: ACPI: Interpreter enabled Sep 13 00:03:09.040351 kernel: ACPI: Using GIC for interrupt routing Sep 13 00:03:09.040387 kernel: ACPI: MCFG table detected, 1 entries Sep 13 00:03:09.040409 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Sep 13 00:03:09.040737 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 13 00:03:09.040940 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 13 00:03:09.041134 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 13 00:03:09.041326 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Sep 13 00:03:09.041552 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Sep 13 00:03:09.041577 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Sep 13 00:03:09.041594 kernel: acpiphp: Slot [1] registered Sep 13 00:03:09.041610 kernel: acpiphp: Slot [2] registered Sep 13 00:03:09.041627 kernel: acpiphp: Slot [3] registered Sep 13 00:03:09.041643 kernel: acpiphp: Slot [4] registered Sep 13 00:03:09.041659 kernel: acpiphp: Slot [5] registered Sep 13 00:03:09.041675 kernel: acpiphp: Slot [6] registered Sep 13 00:03:09.041691 kernel: acpiphp: Slot [7] registered Sep 13 00:03:09.041713 kernel: acpiphp: Slot [8] registered Sep 13 00:03:09.041729 kernel: acpiphp: Slot [9] registered Sep 13 00:03:09.041745 kernel: acpiphp: Slot [10] registered Sep 13 00:03:09.041761 kernel: acpiphp: Slot [11] registered Sep 13 00:03:09.041777 kernel: acpiphp: Slot [12] registered Sep 13 00:03:09.041794 kernel: acpiphp: Slot [13] registered Sep 13 00:03:09.041810 kernel: acpiphp: Slot [14] registered Sep 13 00:03:09.041826 kernel: acpiphp: Slot [15] registered Sep 13 00:03:09.041842 kernel: acpiphp: Slot [16] registered Sep 13 00:03:09.041862 kernel: acpiphp: Slot [17] registered Sep 13 00:03:09.041878 kernel: acpiphp: Slot [18] registered Sep 13 00:03:09.041894 kernel: acpiphp: Slot [19] registered Sep 13 00:03:09.041911 kernel: acpiphp: Slot [20] registered Sep 13 00:03:09.041926 kernel: acpiphp: Slot [21] registered Sep 13 00:03:09.041942 kernel: acpiphp: Slot [22] registered Sep 13 00:03:09.041959 kernel: acpiphp: Slot [23] registered Sep 13 00:03:09.041975 kernel: acpiphp: Slot [24] registered Sep 13 00:03:09.041991 kernel: acpiphp: Slot [25] registered Sep 13 00:03:09.042007 kernel: acpiphp: Slot [26] registered Sep 13 00:03:09.042027 kernel: acpiphp: Slot [27] registered Sep 13 00:03:09.042043 kernel: acpiphp: Slot [28] registered Sep 13 00:03:09.042059 kernel: acpiphp: Slot [29] registered Sep 13 00:03:09.042075 kernel: acpiphp: Slot [30] registered Sep 13 00:03:09.042091 kernel: acpiphp: Slot [31] registered Sep 13 00:03:09.042107 kernel: PCI host bridge to bus 0000:00 Sep 13 00:03:09.042304 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Sep 13 00:03:09.054633 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 13 00:03:09.054905 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Sep 13 00:03:09.055129 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Sep 13 00:03:09.055445 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Sep 13 00:03:09.055716 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Sep 13 00:03:09.056005 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Sep 13 00:03:09.056260 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Sep 13 00:03:09.056556 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Sep 13 00:03:09.056802 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 13 00:03:09.057061 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Sep 13 00:03:09.057295 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Sep 13 00:03:09.057563 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Sep 13 00:03:09.057804 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Sep 13 00:03:09.058037 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 13 00:03:09.058275 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Sep 13 00:03:09.058537 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Sep 13 00:03:09.058764 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Sep 13 00:03:09.058990 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Sep 13 00:03:09.059223 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Sep 13 00:03:09.059469 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Sep 13 00:03:09.059684 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 13 00:03:09.059903 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Sep 13 00:03:09.059926 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 13 00:03:09.059943 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 13 00:03:09.059960 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 13 00:03:09.059977 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 13 00:03:09.059994 kernel: iommu: Default domain type: Translated Sep 13 00:03:09.060010 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 13 00:03:09.060027 kernel: vgaarb: loaded Sep 13 00:03:09.060043 kernel: pps_core: LinuxPPS API ver. 1 registered Sep 13 00:03:09.060064 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 13 00:03:09.060081 kernel: PTP clock support registered Sep 13 00:03:09.060097 kernel: Registered efivars operations Sep 13 00:03:09.060114 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 13 00:03:09.060130 kernel: VFS: Disk quotas dquot_6.6.0 Sep 13 00:03:09.060146 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 13 00:03:09.060163 kernel: pnp: PnP ACPI init Sep 13 00:03:09.063587 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Sep 13 00:03:09.063630 kernel: pnp: PnP ACPI: found 1 devices Sep 13 00:03:09.063648 kernel: NET: Registered PF_INET protocol family Sep 13 00:03:09.063666 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 13 00:03:09.063683 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 13 00:03:09.063700 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 13 00:03:09.063716 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 13 00:03:09.063733 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Sep 13 00:03:09.063750 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 13 00:03:09.063767 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 13 00:03:09.063787 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 13 00:03:09.063804 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 13 00:03:09.063820 kernel: PCI: CLS 0 bytes, default 64 Sep 13 00:03:09.063836 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Sep 13 00:03:09.063854 kernel: kvm [1]: HYP mode not available Sep 13 00:03:09.063871 kernel: Initialise system trusted keyrings Sep 13 00:03:09.063887 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 13 00:03:09.063904 kernel: Key type asymmetric registered Sep 13 00:03:09.063920 kernel: Asymmetric key parser 'x509' registered Sep 13 00:03:09.063940 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 13 00:03:09.063957 kernel: io scheduler mq-deadline registered Sep 13 00:03:09.063973 kernel: io scheduler kyber registered Sep 13 00:03:09.063989 kernel: io scheduler bfq registered Sep 13 00:03:09.064207 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Sep 13 00:03:09.064232 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 13 00:03:09.064249 kernel: ACPI: button: Power Button [PWRB] Sep 13 00:03:09.064266 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Sep 13 00:03:09.064282 kernel: ACPI: button: Sleep Button [SLPB] Sep 13 00:03:09.064304 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 13 00:03:09.064321 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Sep 13 00:03:09.064598 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Sep 13 00:03:09.064628 kernel: printk: console [ttyS0] disabled Sep 13 00:03:09.064645 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Sep 13 00:03:09.064663 kernel: printk: console [ttyS0] enabled Sep 13 00:03:09.064680 kernel: printk: bootconsole [uart0] disabled Sep 13 00:03:09.064696 kernel: thunder_xcv, ver 1.0 Sep 13 00:03:09.064713 kernel: thunder_bgx, ver 1.0 Sep 13 00:03:09.064739 kernel: nicpf, ver 1.0 Sep 13 00:03:09.064756 kernel: nicvf, ver 1.0 Sep 13 00:03:09.065008 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 13 00:03:09.065209 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-13T00:03:08 UTC (1757721788) Sep 13 00:03:09.065233 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 13 00:03:09.065250 kernel: NET: Registered PF_INET6 protocol family Sep 13 00:03:09.065266 kernel: Segment Routing with IPv6 Sep 13 00:03:09.065283 kernel: In-situ OAM (IOAM) with IPv6 Sep 13 00:03:09.065305 kernel: NET: Registered PF_PACKET protocol family Sep 13 00:03:09.065321 kernel: Key type dns_resolver registered Sep 13 00:03:09.065337 kernel: registered taskstats version 1 Sep 13 00:03:09.065354 kernel: Loading compiled-in X.509 certificates Sep 13 00:03:09.065396 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.192-flatcar: 47ac98e9306f36eebe4291d409359a5a5d0c2b9c' Sep 13 00:03:09.065416 kernel: Key type .fscrypt registered Sep 13 00:03:09.065433 kernel: Key type fscrypt-provisioning registered Sep 13 00:03:09.065449 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 13 00:03:09.065465 kernel: ima: Allocated hash algorithm: sha1 Sep 13 00:03:09.065487 kernel: ima: No architecture policies found Sep 13 00:03:09.065503 kernel: clk: Disabling unused clocks Sep 13 00:03:09.065519 kernel: Freeing unused kernel memory: 36416K Sep 13 00:03:09.065536 kernel: Run /init as init process Sep 13 00:03:09.065552 kernel: with arguments: Sep 13 00:03:09.065568 kernel: /init Sep 13 00:03:09.065584 kernel: with environment: Sep 13 00:03:09.065600 kernel: HOME=/ Sep 13 00:03:09.065616 kernel: TERM=linux Sep 13 00:03:09.065636 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 13 00:03:09.065658 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) Sep 13 00:03:09.065680 systemd[1]: Detected virtualization amazon. Sep 13 00:03:09.065698 systemd[1]: Detected architecture arm64. Sep 13 00:03:09.065715 systemd[1]: Running in initrd. Sep 13 00:03:09.065732 systemd[1]: No hostname configured, using default hostname. Sep 13 00:03:09.065749 systemd[1]: Hostname set to . Sep 13 00:03:09.065773 systemd[1]: Initializing machine ID from VM UUID. Sep 13 00:03:09.065791 systemd[1]: Queued start job for default target initrd.target. Sep 13 00:03:09.065808 systemd[1]: Started systemd-ask-password-console.path. Sep 13 00:03:09.065825 systemd[1]: Reached target cryptsetup.target. Sep 13 00:03:09.065842 systemd[1]: Reached target paths.target. Sep 13 00:03:09.065859 systemd[1]: Reached target slices.target. Sep 13 00:03:09.065877 systemd[1]: Reached target swap.target. Sep 13 00:03:09.065894 systemd[1]: Reached target timers.target. Sep 13 00:03:09.065916 systemd[1]: Listening on iscsid.socket. Sep 13 00:03:09.065934 systemd[1]: Listening on iscsiuio.socket. Sep 13 00:03:09.065952 systemd[1]: Listening on systemd-journald-audit.socket. Sep 13 00:03:09.065969 systemd[1]: Listening on systemd-journald-dev-log.socket. Sep 13 00:03:09.065987 systemd[1]: Listening on systemd-journald.socket. Sep 13 00:03:09.066004 systemd[1]: Listening on systemd-networkd.socket. Sep 13 00:03:09.066022 systemd[1]: Listening on systemd-udevd-control.socket. Sep 13 00:03:09.066040 systemd[1]: Listening on systemd-udevd-kernel.socket. Sep 13 00:03:09.066061 systemd[1]: Reached target sockets.target. Sep 13 00:03:09.066079 systemd[1]: Starting kmod-static-nodes.service... Sep 13 00:03:09.066097 systemd[1]: Finished network-cleanup.service. Sep 13 00:03:09.066114 systemd[1]: Starting systemd-fsck-usr.service... Sep 13 00:03:09.066132 systemd[1]: Starting systemd-journald.service... Sep 13 00:03:09.066149 systemd[1]: Starting systemd-modules-load.service... Sep 13 00:03:09.066167 systemd[1]: Starting systemd-resolved.service... Sep 13 00:03:09.066184 systemd[1]: Starting systemd-vconsole-setup.service... Sep 13 00:03:09.066201 systemd[1]: Finished kmod-static-nodes.service. Sep 13 00:03:09.066223 kernel: audit: type=1130 audit(1757721789.033:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:09.066242 systemd[1]: Finished systemd-fsck-usr.service. Sep 13 00:03:09.076406 kernel: audit: type=1130 audit(1757721789.054:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:09.076480 systemd[1]: Finished systemd-vconsole-setup.service. Sep 13 00:03:09.076504 systemd[1]: Starting dracut-cmdline-ask.service... Sep 13 00:03:09.076526 systemd-journald[309]: Journal started Sep 13 00:03:09.076648 systemd-journald[309]: Runtime Journal (/run/log/journal/ec228bb498135fffcdc00402ef628e8c) is 8.0M, max 75.4M, 67.4M free. Sep 13 00:03:09.033000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:09.054000 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' Sep 13 00:03:09.020749 systemd-modules-load[310]: Inserted module 'overlay' Sep 13 00:03:09.096600 kernel: audit: type=1130 audit(1757721789.072:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:09.096660 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Sep 13 00:03:09.072000 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' Sep 13 00:03:09.118607 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 13 00:03:09.133426 systemd[1]: Started systemd-journald.service. Sep 13 00:03:09.133495 kernel: audit: type=1130 audit(1757721789.131: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' Sep 13 00:03:09.131000 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' Sep 13 00:03:09.143231 systemd-modules-load[310]: Inserted module 'br_netfilter' Sep 13 00:03:09.145297 kernel: Bridge firewalling registered Sep 13 00:03:09.145000 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' Sep 13 00:03:09.146447 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Sep 13 00:03:09.158894 kernel: audit: type=1130 audit(1757721789.145:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:09.159126 systemd-resolved[311]: Positive Trust Anchors: Sep 13 00:03:09.159155 systemd-resolved[311]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 13 00:03:09.159211 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 Sep 13 00:03:09.170257 systemd[1]: Finished dracut-cmdline-ask.service. Sep 13 00:03:09.181000 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' Sep 13 00:03:09.198425 kernel: audit: type=1130 audit(1757721789.181:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:09.193534 systemd[1]: Starting dracut-cmdline.service... Sep 13 00:03:09.215463 kernel: SCSI subsystem initialized Sep 13 00:03:09.236572 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 13 00:03:09.236647 kernel: device-mapper: uevent: version 1.0.3 Sep 13 00:03:09.241214 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Sep 13 00:03:09.241285 dracut-cmdline[326]: dracut-dracut-053 Sep 13 00:03:09.249401 dracut-cmdline[326]: 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=563df7b8a9b19b8c496587ae06f3c3ec1604a5105c3a3f313c9ccaa21d8055ca Sep 13 00:03:09.264218 systemd-modules-load[310]: Inserted module 'dm_multipath' Sep 13 00:03:09.270199 systemd[1]: Finished systemd-modules-load.service. Sep 13 00:03:09.271000 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' Sep 13 00:03:09.289056 kernel: audit: type=1130 audit(1757721789.271:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:09.283686 systemd[1]: Starting systemd-sysctl.service... Sep 13 00:03:09.312466 systemd[1]: Finished systemd-sysctl.service. Sep 13 00:03:09.314000 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' Sep 13 00:03:09.325432 kernel: audit: type=1130 audit(1757721789.314:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:09.428405 kernel: Loading iSCSI transport class v2.0-870. Sep 13 00:03:09.448406 kernel: iscsi: registered transport (tcp) Sep 13 00:03:09.476751 kernel: iscsi: registered transport (qla4xxx) Sep 13 00:03:09.476826 kernel: QLogic iSCSI HBA Driver Sep 13 00:03:09.622272 systemd-resolved[311]: Defaulting to hostname 'linux'. Sep 13 00:03:09.624965 kernel: random: crng init done Sep 13 00:03:09.626418 systemd[1]: Started systemd-resolved.service. Sep 13 00:03:09.626000 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' Sep 13 00:03:09.628422 systemd[1]: Reached target nss-lookup.target. Sep 13 00:03:09.641084 kernel: audit: type=1130 audit(1757721789.626:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:09.658489 systemd[1]: Finished dracut-cmdline.service. Sep 13 00:03:09.660000 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' Sep 13 00:03:09.663883 systemd[1]: Starting dracut-pre-udev.service... Sep 13 00:03:09.735433 kernel: raid6: neonx8 gen() 6312 MB/s Sep 13 00:03:09.753418 kernel: raid6: neonx8 xor() 4781 MB/s Sep 13 00:03:09.771411 kernel: raid6: neonx4 gen() 6435 MB/s Sep 13 00:03:09.789408 kernel: raid6: neonx4 xor() 4983 MB/s Sep 13 00:03:09.807406 kernel: raid6: neonx2 gen() 5712 MB/s Sep 13 00:03:09.825410 kernel: raid6: neonx2 xor() 4575 MB/s Sep 13 00:03:09.843408 kernel: raid6: neonx1 gen() 4432 MB/s Sep 13 00:03:09.861408 kernel: raid6: neonx1 xor() 3699 MB/s Sep 13 00:03:09.879409 kernel: raid6: int64x8 gen() 3398 MB/s Sep 13 00:03:09.897408 kernel: raid6: int64x8 xor() 2093 MB/s Sep 13 00:03:09.915407 kernel: raid6: int64x4 gen() 3766 MB/s Sep 13 00:03:09.933408 kernel: raid6: int64x4 xor() 2187 MB/s Sep 13 00:03:09.951407 kernel: raid6: int64x2 gen() 3543 MB/s Sep 13 00:03:09.969408 kernel: raid6: int64x2 xor() 1905 MB/s Sep 13 00:03:10.003389 kernel: raid6: int64x1 gen() 2746 MB/s Sep 13 00:03:10.008012 kernel: raid6: int64x1 xor() 1436 MB/s Sep 13 00:03:10.008043 kernel: raid6: using algorithm neonx4 gen() 6435 MB/s Sep 13 00:03:10.010318 kernel: raid6: .... xor() 4983 MB/s, rmw enabled Sep 13 00:03:10.012381 kernel: raid6: using neon recovery algorithm Sep 13 00:03:10.031637 kernel: xor: measuring software checksum speed Sep 13 00:03:10.031703 kernel: 8regs : 9296 MB/sec Sep 13 00:03:10.033697 kernel: 32regs : 10882 MB/sec Sep 13 00:03:10.035850 kernel: arm64_neon : 9675 MB/sec Sep 13 00:03:10.037976 kernel: xor: using function: 32regs (10882 MB/sec) Sep 13 00:03:10.135449 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Sep 13 00:03:10.154730 systemd[1]: Finished dracut-pre-udev.service. Sep 13 00:03:10.155000 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' Sep 13 00:03:10.157000 audit: BPF prog-id=7 op=LOAD Sep 13 00:03:10.158000 audit: BPF prog-id=8 op=LOAD Sep 13 00:03:10.160230 systemd[1]: Starting systemd-udevd.service... Sep 13 00:03:10.190713 systemd-udevd[509]: Using default interface naming scheme 'v252'. Sep 13 00:03:10.202222 systemd[1]: Started systemd-udevd.service. Sep 13 00:03:10.204000 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' Sep 13 00:03:10.209576 systemd[1]: Starting dracut-pre-trigger.service... Sep 13 00:03:10.243269 dracut-pre-trigger[518]: rd.md=0: removing MD RAID activation Sep 13 00:03:10.311628 systemd[1]: Finished dracut-pre-trigger.service. Sep 13 00:03:10.314000 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' Sep 13 00:03:10.316982 systemd[1]: Starting systemd-udev-trigger.service... Sep 13 00:03:10.433585 systemd[1]: Finished systemd-udev-trigger.service. Sep 13 00:03:10.434000 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' Sep 13 00:03:10.546851 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 13 00:03:10.546918 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Sep 13 00:03:10.573609 kernel: ena 0000:00:05.0: ENA device version: 0.10 Sep 13 00:03:10.573901 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Sep 13 00:03:10.574152 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:f1:5a:5a:5a:0b Sep 13 00:03:10.577299 (udev-worker)[559]: Network interface NamePolicy= disabled on kernel command line. Sep 13 00:03:10.587955 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Sep 13 00:03:10.588031 kernel: nvme nvme0: pci function 0000:00:04.0 Sep 13 00:03:10.599828 kernel: nvme nvme0: 2/0/0 default/read/poll queues Sep 13 00:03:10.607499 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Sep 13 00:03:10.607571 kernel: GPT:9289727 != 16777215 Sep 13 00:03:10.607595 kernel: GPT:Alternate GPT header not at the end of the disk. Sep 13 00:03:10.609825 kernel: GPT:9289727 != 16777215 Sep 13 00:03:10.611205 kernel: GPT: Use GNU Parted to correct GPT errors. Sep 13 00:03:10.613186 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 13 00:03:10.686415 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/nvme0n1p6 scanned by (udev-worker) (557) Sep 13 00:03:10.782119 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Sep 13 00:03:10.809481 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Sep 13 00:03:10.835870 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Sep 13 00:03:10.840794 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Sep 13 00:03:10.857577 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Sep 13 00:03:10.872264 systemd[1]: Starting disk-uuid.service... Sep 13 00:03:10.884527 disk-uuid[665]: Primary Header is updated. Sep 13 00:03:10.884527 disk-uuid[665]: Secondary Entries is updated. Sep 13 00:03:10.884527 disk-uuid[665]: Secondary Header is updated. Sep 13 00:03:10.895454 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 13 00:03:10.905419 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 13 00:03:11.914405 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 13 00:03:11.916274 disk-uuid[666]: The operation has completed successfully. Sep 13 00:03:12.112948 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 13 00:03:12.113218 systemd[1]: Finished disk-uuid.service. Sep 13 00:03:12.117000 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' Sep 13 00:03:12.117000 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' Sep 13 00:03:12.140599 systemd[1]: Starting verity-setup.service... Sep 13 00:03:12.179423 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Sep 13 00:03:12.275925 systemd[1]: Found device dev-mapper-usr.device. Sep 13 00:03:12.282256 systemd[1]: Mounting sysusr-usr.mount... Sep 13 00:03:12.289899 systemd[1]: Finished verity-setup.service. Sep 13 00:03:12.292000 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' Sep 13 00:03:12.383425 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Sep 13 00:03:12.383698 systemd[1]: Mounted sysusr-usr.mount. Sep 13 00:03:12.390455 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Sep 13 00:03:12.394981 systemd[1]: Starting ignition-setup.service... Sep 13 00:03:12.408157 systemd[1]: Starting parse-ip-for-networkd.service... Sep 13 00:03:12.435063 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 13 00:03:12.435147 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 13 00:03:12.437597 kernel: BTRFS info (device nvme0n1p6): has skinny extents Sep 13 00:03:12.449419 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 13 00:03:12.471335 systemd[1]: mnt-oem.mount: Deactivated successfully. Sep 13 00:03:12.492922 systemd[1]: Finished ignition-setup.service. Sep 13 00:03:12.497000 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' Sep 13 00:03:12.501239 systemd[1]: Starting ignition-fetch-offline.service... Sep 13 00:03:12.600498 systemd[1]: Finished parse-ip-for-networkd.service. Sep 13 00:03:12.608000 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' Sep 13 00:03:12.609000 audit: BPF prog-id=9 op=LOAD Sep 13 00:03:12.611872 systemd[1]: Starting systemd-networkd.service... Sep 13 00:03:12.664568 systemd-networkd[1190]: lo: Link UP Sep 13 00:03:12.666549 systemd-networkd[1190]: lo: Gained carrier Sep 13 00:03:12.669276 systemd-networkd[1190]: Enumeration completed Sep 13 00:03:12.669608 systemd[1]: Started systemd-networkd.service. Sep 13 00:03:12.674000 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' Sep 13 00:03:12.675501 systemd[1]: Reached target network.target. Sep 13 00:03:12.695053 kernel: kauditd_printk_skb: 13 callbacks suppressed Sep 13 00:03:12.695095 kernel: audit: type=1130 audit(1757721792.674:24): 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' Sep 13 00:03:12.675954 systemd-networkd[1190]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 13 00:03:12.694023 systemd-networkd[1190]: eth0: Link UP Sep 13 00:03:12.694032 systemd-networkd[1190]: eth0: Gained carrier Sep 13 00:03:12.694838 systemd[1]: Starting iscsiuio.service... Sep 13 00:03:12.715783 systemd[1]: Started iscsiuio.service. Sep 13 00:03:12.723000 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' Sep 13 00:03:12.733751 systemd[1]: Starting iscsid.service... Sep 13 00:03:12.737660 kernel: audit: type=1130 audit(1757721792.723:25): 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' Sep 13 00:03:12.742555 systemd-networkd[1190]: eth0: DHCPv4 address 172.31.27.4/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 13 00:03:12.749208 iscsid[1195]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Sep 13 00:03:12.749208 iscsid[1195]: 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]. Sep 13 00:03:12.749208 iscsid[1195]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Sep 13 00:03:12.749208 iscsid[1195]: If using hardware iscsi like qla4xxx this message can be ignored. Sep 13 00:03:12.749208 iscsid[1195]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Sep 13 00:03:12.774000 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' Sep 13 00:03:12.789877 iscsid[1195]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Sep 13 00:03:12.773300 systemd[1]: Started iscsid.service. Sep 13 00:03:12.776828 systemd[1]: Starting dracut-initqueue.service... Sep 13 00:03:12.800902 kernel: audit: type=1130 audit(1757721792.774:26): 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' Sep 13 00:03:12.812137 systemd[1]: Finished dracut-initqueue.service. Sep 13 00:03:12.815868 systemd[1]: Reached target remote-fs-pre.target. Sep 13 00:03:12.836832 kernel: audit: type=1130 audit(1757721792.813:27): 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' Sep 13 00:03:12.813000 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' Sep 13 00:03:12.826054 systemd[1]: Reached target remote-cryptsetup.target. Sep 13 00:03:12.828167 systemd[1]: Reached target remote-fs.target. Sep 13 00:03:12.832296 systemd[1]: Starting dracut-pre-mount.service... Sep 13 00:03:12.856804 systemd[1]: Finished dracut-pre-mount.service. Sep 13 00:03:12.870607 kernel: audit: type=1130 audit(1757721792.857:28): 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' Sep 13 00:03:12.857000 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' Sep 13 00:03:13.376446 ignition[1124]: Ignition 2.14.0 Sep 13 00:03:13.377004 ignition[1124]: Stage: fetch-offline Sep 13 00:03:13.377920 ignition[1124]: reading system config file "/usr/lib/ignition/base.d/base.ign" Sep 13 00:03:13.377986 ignition[1124]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Sep 13 00:03:13.404733 ignition[1124]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 13 00:03:13.407740 ignition[1124]: Ignition finished successfully Sep 13 00:03:13.410671 systemd[1]: Finished ignition-fetch-offline.service. Sep 13 00:03:13.409000 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' Sep 13 00:03:13.417194 systemd[1]: Starting ignition-fetch.service... Sep 13 00:03:13.435728 kernel: audit: type=1130 audit(1757721793.409:29): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:13.443812 ignition[1214]: Ignition 2.14.0 Sep 13 00:03:13.443841 ignition[1214]: Stage: fetch Sep 13 00:03:13.444143 ignition[1214]: reading system config file "/usr/lib/ignition/base.d/base.ign" Sep 13 00:03:13.444206 ignition[1214]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Sep 13 00:03:13.461056 ignition[1214]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 13 00:03:13.464195 ignition[1214]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 13 00:03:13.473434 ignition[1214]: INFO : PUT result: OK Sep 13 00:03:13.477261 ignition[1214]: DEBUG : parsed url from cmdline: "" Sep 13 00:03:13.479444 ignition[1214]: INFO : no config URL provided Sep 13 00:03:13.479444 ignition[1214]: INFO : reading system config file "/usr/lib/ignition/user.ign" Sep 13 00:03:13.479444 ignition[1214]: INFO : no config at "/usr/lib/ignition/user.ign" Sep 13 00:03:13.479444 ignition[1214]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 13 00:03:13.489642 ignition[1214]: INFO : PUT result: OK Sep 13 00:03:13.489642 ignition[1214]: INFO : GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Sep 13 00:03:13.494197 ignition[1214]: INFO : GET result: OK Sep 13 00:03:13.494197 ignition[1214]: DEBUG : parsing config with SHA512: c0d6b9b926b0853d90ace5c2485a5ccdd936ea01dfd22da10a8419451f4be61e88776bfcedf5b703fc1457c1412dda46f2727292b13e976074e7bd18b7ab9461 Sep 13 00:03:13.507068 unknown[1214]: fetched base config from "system" Sep 13 00:03:13.507098 unknown[1214]: fetched base config from "system" Sep 13 00:03:13.507113 unknown[1214]: fetched user config from "aws" Sep 13 00:03:13.513000 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' Sep 13 00:03:13.510165 ignition[1214]: fetch: fetch complete Sep 13 00:03:13.512952 systemd[1]: Finished ignition-fetch.service. Sep 13 00:03:13.533454 kernel: audit: type=1130 audit(1757721793.513:30): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:13.510183 ignition[1214]: fetch: fetch passed Sep 13 00:03:13.518040 systemd[1]: Starting ignition-kargs.service... Sep 13 00:03:13.510308 ignition[1214]: Ignition finished successfully Sep 13 00:03:13.550744 ignition[1220]: Ignition 2.14.0 Sep 13 00:03:13.550774 ignition[1220]: Stage: kargs Sep 13 00:03:13.551109 ignition[1220]: reading system config file "/usr/lib/ignition/base.d/base.ign" Sep 13 00:03:13.551171 ignition[1220]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Sep 13 00:03:13.567531 ignition[1220]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 13 00:03:13.570338 ignition[1220]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 13 00:03:13.574047 ignition[1220]: INFO : PUT result: OK Sep 13 00:03:13.583615 ignition[1220]: kargs: kargs passed Sep 13 00:03:13.583775 ignition[1220]: Ignition finished successfully Sep 13 00:03:13.589042 systemd[1]: Finished ignition-kargs.service. Sep 13 00:03:13.591000 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' Sep 13 00:03:13.594237 systemd[1]: Starting ignition-disks.service... Sep 13 00:03:13.606554 kernel: audit: type=1130 audit(1757721793.591:31): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:13.611159 ignition[1226]: Ignition 2.14.0 Sep 13 00:03:13.611189 ignition[1226]: Stage: disks Sep 13 00:03:13.611559 ignition[1226]: reading system config file "/usr/lib/ignition/base.d/base.ign" Sep 13 00:03:13.611620 ignition[1226]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Sep 13 00:03:13.628104 ignition[1226]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 13 00:03:13.630844 ignition[1226]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 13 00:03:13.633871 ignition[1226]: INFO : PUT result: OK Sep 13 00:03:13.638838 ignition[1226]: disks: disks passed Sep 13 00:03:13.639536 ignition[1226]: Ignition finished successfully Sep 13 00:03:13.643613 systemd[1]: Finished ignition-disks.service. Sep 13 00:03:13.647243 systemd[1]: Reached target initrd-root-device.target. Sep 13 00:03:13.661461 kernel: audit: type=1130 audit(1757721793.645:32): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:13.645000 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' Sep 13 00:03:13.649455 systemd[1]: Reached target local-fs-pre.target. Sep 13 00:03:13.661506 systemd[1]: Reached target local-fs.target. Sep 13 00:03:13.665667 systemd[1]: Reached target sysinit.target. Sep 13 00:03:13.669735 systemd[1]: Reached target basic.target. Sep 13 00:03:13.674399 systemd[1]: Starting systemd-fsck-root.service... Sep 13 00:03:13.725098 systemd-fsck[1234]: ROOT: clean, 629/553520 files, 56027/553472 blocks Sep 13 00:03:13.730273 systemd[1]: Finished systemd-fsck-root.service. Sep 13 00:03:13.742711 kernel: audit: type=1130 audit(1757721793.731:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:13.731000 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' Sep 13 00:03:13.735531 systemd[1]: Mounting sysroot.mount... Sep 13 00:03:13.763409 kernel: EXT4-fs (nvme0n1p9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Sep 13 00:03:13.764876 systemd[1]: Mounted sysroot.mount. Sep 13 00:03:13.765203 systemd[1]: Reached target initrd-root-fs.target. Sep 13 00:03:13.781213 systemd[1]: Mounting sysroot-usr.mount... Sep 13 00:03:13.788616 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Sep 13 00:03:13.788704 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 13 00:03:13.788768 systemd[1]: Reached target ignition-diskful.target. Sep 13 00:03:13.793463 systemd[1]: Mounted sysroot-usr.mount. Sep 13 00:03:13.821299 systemd[1]: Mounting sysroot-usr-share-oem.mount... Sep 13 00:03:13.827097 systemd[1]: Starting initrd-setup-root.service... Sep 13 00:03:13.847630 initrd-setup-root[1256]: cut: /sysroot/etc/passwd: No such file or directory Sep 13 00:03:13.855426 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 scanned by mount (1251) Sep 13 00:03:13.862521 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 13 00:03:13.862588 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 13 00:03:13.862612 kernel: BTRFS info (device nvme0n1p6): has skinny extents Sep 13 00:03:13.871926 initrd-setup-root[1281]: cut: /sysroot/etc/group: No such file or directory Sep 13 00:03:13.877137 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 13 00:03:13.882342 systemd[1]: Mounted sysroot-usr-share-oem.mount. Sep 13 00:03:13.891744 initrd-setup-root[1290]: cut: /sysroot/etc/shadow: No such file or directory Sep 13 00:03:13.902425 initrd-setup-root[1298]: cut: /sysroot/etc/gshadow: No such file or directory Sep 13 00:03:14.010556 systemd-networkd[1190]: eth0: Gained IPv6LL Sep 13 00:03:14.167104 systemd[1]: Finished initrd-setup-root.service. Sep 13 00:03:14.169000 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' Sep 13 00:03:14.172071 systemd[1]: Starting ignition-mount.service... Sep 13 00:03:14.181741 systemd[1]: Starting sysroot-boot.service... Sep 13 00:03:14.191705 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. Sep 13 00:03:14.192347 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. Sep 13 00:03:14.216494 ignition[1316]: INFO : Ignition 2.14.0 Sep 13 00:03:14.218628 ignition[1316]: INFO : Stage: mount Sep 13 00:03:14.218628 ignition[1316]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Sep 13 00:03:14.218628 ignition[1316]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Sep 13 00:03:14.241128 ignition[1316]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 13 00:03:14.244114 ignition[1316]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 13 00:03:14.249829 ignition[1316]: INFO : PUT result: OK Sep 13 00:03:14.254956 systemd[1]: Finished sysroot-boot.service. Sep 13 00:03:14.254000 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' Sep 13 00:03:14.261531 ignition[1316]: INFO : mount: mount passed Sep 13 00:03:14.263576 ignition[1316]: INFO : Ignition finished successfully Sep 13 00:03:14.267328 systemd[1]: Finished ignition-mount.service. Sep 13 00:03:14.269000 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' Sep 13 00:03:14.272745 systemd[1]: Starting ignition-files.service... Sep 13 00:03:14.288009 systemd[1]: Mounting sysroot-usr-share-oem.mount... Sep 13 00:03:14.309435 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by mount (1326) Sep 13 00:03:14.316976 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 13 00:03:14.317046 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 13 00:03:14.317070 kernel: BTRFS info (device nvme0n1p6): has skinny extents Sep 13 00:03:14.327425 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 13 00:03:14.332670 systemd[1]: Mounted sysroot-usr-share-oem.mount. Sep 13 00:03:14.357718 ignition[1345]: INFO : Ignition 2.14.0 Sep 13 00:03:14.357718 ignition[1345]: INFO : Stage: files Sep 13 00:03:14.361535 ignition[1345]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Sep 13 00:03:14.361535 ignition[1345]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Sep 13 00:03:14.379742 ignition[1345]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 13 00:03:14.382547 ignition[1345]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 13 00:03:14.386215 ignition[1345]: INFO : PUT result: OK Sep 13 00:03:14.390867 ignition[1345]: DEBUG : files: compiled without relabeling support, skipping Sep 13 00:03:14.394606 ignition[1345]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 13 00:03:14.394606 ignition[1345]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 13 00:03:14.432085 ignition[1345]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 13 00:03:14.435584 ignition[1345]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 13 00:03:14.441729 unknown[1345]: wrote ssh authorized keys file for user: core Sep 13 00:03:14.444670 ignition[1345]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 13 00:03:14.449041 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/eks/bootstrap.sh" Sep 13 00:03:14.454194 ignition[1345]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Sep 13 00:03:14.462850 ignition[1345]: INFO : op(1): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2920387980" Sep 13 00:03:14.466227 ignition[1345]: CRITICAL : op(1): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2920387980": device or resource busy Sep 13 00:03:14.466227 ignition[1345]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2920387980", trying btrfs: device or resource busy Sep 13 00:03:14.466227 ignition[1345]: INFO : op(2): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2920387980" Sep 13 00:03:14.466227 ignition[1345]: INFO : op(2): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2920387980" Sep 13 00:03:14.481389 ignition[1345]: INFO : op(3): [started] unmounting "/mnt/oem2920387980" Sep 13 00:03:14.481389 ignition[1345]: INFO : op(3): [finished] unmounting "/mnt/oem2920387980" Sep 13 00:03:14.481389 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/eks/bootstrap.sh" Sep 13 00:03:14.494821 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 13 00:03:14.494821 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 13 00:03:14.494821 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Sep 13 00:03:14.494821 ignition[1345]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Sep 13 00:03:14.520029 ignition[1345]: INFO : op(4): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3333318586" Sep 13 00:03:14.520029 ignition[1345]: CRITICAL : op(4): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3333318586": device or resource busy Sep 13 00:03:14.520029 ignition[1345]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3333318586", trying btrfs: device or resource busy Sep 13 00:03:14.520029 ignition[1345]: INFO : op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3333318586" Sep 13 00:03:14.520029 ignition[1345]: INFO : op(5): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3333318586" Sep 13 00:03:14.520029 ignition[1345]: INFO : op(6): [started] unmounting "/mnt/oem3333318586" Sep 13 00:03:14.520029 ignition[1345]: INFO : op(6): [finished] unmounting "/mnt/oem3333318586" Sep 13 00:03:14.520029 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Sep 13 00:03:14.520029 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Sep 13 00:03:14.520029 ignition[1345]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Sep 13 00:03:14.562231 ignition[1345]: INFO : op(7): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem325604767" Sep 13 00:03:14.562231 ignition[1345]: CRITICAL : op(7): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem325604767": device or resource busy Sep 13 00:03:14.562231 ignition[1345]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem325604767", trying btrfs: device or resource busy Sep 13 00:03:14.562231 ignition[1345]: INFO : op(8): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem325604767" Sep 13 00:03:14.562231 ignition[1345]: INFO : op(8): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem325604767" Sep 13 00:03:14.562231 ignition[1345]: INFO : op(9): [started] unmounting "/mnt/oem325604767" Sep 13 00:03:14.583810 ignition[1345]: INFO : op(9): [finished] unmounting "/mnt/oem325604767" Sep 13 00:03:14.583810 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Sep 13 00:03:14.583810 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" Sep 13 00:03:14.583810 ignition[1345]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Sep 13 00:03:14.608960 ignition[1345]: INFO : op(a): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3698418313" Sep 13 00:03:14.608960 ignition[1345]: CRITICAL : op(a): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3698418313": device or resource busy Sep 13 00:03:14.608960 ignition[1345]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3698418313", trying btrfs: device or resource busy Sep 13 00:03:14.608960 ignition[1345]: INFO : op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3698418313" Sep 13 00:03:14.625024 ignition[1345]: INFO : op(b): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3698418313" Sep 13 00:03:14.625024 ignition[1345]: INFO : op(c): [started] unmounting "/mnt/oem3698418313" Sep 13 00:03:14.625024 ignition[1345]: INFO : op(c): [finished] unmounting "/mnt/oem3698418313" Sep 13 00:03:14.625024 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" Sep 13 00:03:14.625024 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(8): [started] writing file "/sysroot/var/lib/flatcar-install/user_data" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: createFilesystemsFiles: createFiles: op(8): [finished] writing file "/sysroot/var/lib/flatcar-install/user_data" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(9): [started] processing unit "nvidia.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(9): [finished] processing unit "nvidia.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(a): [started] processing unit "coreos-metadata-sshkeys@.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(a): [finished] processing unit "coreos-metadata-sshkeys@.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(b): [started] processing unit "amazon-ssm-agent.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(b): op(c): [started] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(b): op(c): [finished] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(b): [finished] processing unit "amazon-ssm-agent.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(d): [started] setting preset to enabled for "nvidia.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(d): [finished] setting preset to enabled for "nvidia.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(e): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service " Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(e): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service " Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(f): [started] setting preset to enabled for "amazon-ssm-agent.service" Sep 13 00:03:14.643025 ignition[1345]: INFO : files: op(f): [finished] setting preset to enabled for "amazon-ssm-agent.service" Sep 13 00:03:14.704477 ignition[1345]: INFO : files: createResultFile: createFiles: op(10): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 13 00:03:14.704477 ignition[1345]: INFO : files: createResultFile: createFiles: op(10): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 13 00:03:14.704477 ignition[1345]: INFO : files: files passed Sep 13 00:03:14.704477 ignition[1345]: INFO : Ignition finished successfully Sep 13 00:03:14.720000 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' Sep 13 00:03:14.709945 systemd[1]: Finished ignition-files.service. Sep 13 00:03:14.738029 systemd[1]: Starting initrd-setup-root-after-ignition.service... Sep 13 00:03:14.740408 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Sep 13 00:03:14.748827 systemd[1]: Starting ignition-quench.service... Sep 13 00:03:14.758184 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 13 00:03:14.760933 systemd[1]: Finished ignition-quench.service. Sep 13 00:03:14.764000 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' Sep 13 00:03:14.764000 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' Sep 13 00:03:14.772714 initrd-setup-root-after-ignition[1371]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 13 00:03:14.778550 systemd[1]: Finished initrd-setup-root-after-ignition.service. Sep 13 00:03:14.781000 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' Sep 13 00:03:14.783350 systemd[1]: Reached target ignition-complete.target. Sep 13 00:03:14.788972 systemd[1]: Starting initrd-parse-etc.service... Sep 13 00:03:14.819075 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 13 00:03:14.821427 systemd[1]: Finished initrd-parse-etc.service. Sep 13 00:03:14.825000 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' Sep 13 00:03:14.825000 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' Sep 13 00:03:14.826724 systemd[1]: Reached target initrd-fs.target. Sep 13 00:03:14.830564 systemd[1]: Reached target initrd.target. Sep 13 00:03:14.834116 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Sep 13 00:03:14.838621 systemd[1]: Starting dracut-pre-pivot.service... Sep 13 00:03:14.863911 systemd[1]: Finished dracut-pre-pivot.service. Sep 13 00:03:14.866000 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' Sep 13 00:03:14.869046 systemd[1]: Starting initrd-cleanup.service... Sep 13 00:03:14.890391 systemd[1]: Stopped target nss-lookup.target. Sep 13 00:03:14.894483 systemd[1]: Stopped target remote-cryptsetup.target. Sep 13 00:03:14.899053 systemd[1]: Stopped target timers.target. Sep 13 00:03:14.902930 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 13 00:03:14.905609 systemd[1]: Stopped dracut-pre-pivot.service. Sep 13 00:03:14.908000 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' Sep 13 00:03:14.909962 systemd[1]: Stopped target initrd.target. Sep 13 00:03:14.913748 systemd[1]: Stopped target basic.target. Sep 13 00:03:14.917445 systemd[1]: Stopped target ignition-complete.target. Sep 13 00:03:14.921795 systemd[1]: Stopped target ignition-diskful.target. Sep 13 00:03:14.925996 systemd[1]: Stopped target initrd-root-device.target. Sep 13 00:03:14.930283 systemd[1]: Stopped target remote-fs.target. Sep 13 00:03:14.934077 systemd[1]: Stopped target remote-fs-pre.target. Sep 13 00:03:14.938143 systemd[1]: Stopped target sysinit.target. Sep 13 00:03:14.941949 systemd[1]: Stopped target local-fs.target. Sep 13 00:03:14.945792 systemd[1]: Stopped target local-fs-pre.target. Sep 13 00:03:14.949809 systemd[1]: Stopped target swap.target. Sep 13 00:03:14.953314 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 13 00:03:14.955867 systemd[1]: Stopped dracut-pre-mount.service. Sep 13 00:03:14.958000 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' Sep 13 00:03:14.960025 systemd[1]: Stopped target cryptsetup.target. Sep 13 00:03:14.963552 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 13 00:03:14.965856 systemd[1]: Stopped dracut-initqueue.service. Sep 13 00:03:14.968000 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' Sep 13 00:03:14.969690 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 13 00:03:14.972444 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Sep 13 00:03:14.975000 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' Sep 13 00:03:14.976947 systemd[1]: ignition-files.service: Deactivated successfully. Sep 13 00:03:14.979248 systemd[1]: Stopped ignition-files.service. Sep 13 00:03:14.981000 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' Sep 13 00:03:14.984439 systemd[1]: Stopping ignition-mount.service... Sep 13 00:03:14.994000 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' Sep 13 00:03:15.010515 ignition[1384]: INFO : Ignition 2.14.0 Sep 13 00:03:15.010515 ignition[1384]: INFO : Stage: umount Sep 13 00:03:15.010515 ignition[1384]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Sep 13 00:03:15.010515 ignition[1384]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Sep 13 00:03:15.033639 iscsid[1195]: iscsid shutting down. Sep 13 00:03:14.986951 systemd[1]: Stopping iscsid.service... Sep 13 00:03:14.993474 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 13 00:03:15.038000 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' Sep 13 00:03:14.993813 systemd[1]: Stopped kmod-static-nodes.service. Sep 13 00:03:14.997950 systemd[1]: Stopping sysroot-boot.service... Sep 13 00:03:15.008055 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 13 00:03:15.013105 systemd[1]: Stopped systemd-udev-trigger.service. Sep 13 00:03:15.040233 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 13 00:03:15.054000 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' Sep 13 00:03:15.060680 ignition[1384]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 13 00:03:15.060680 ignition[1384]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 13 00:03:15.043281 systemd[1]: Stopped dracut-pre-trigger.service. Sep 13 00:03:15.071429 ignition[1384]: INFO : PUT result: OK Sep 13 00:03:15.072000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:15.069045 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 13 00:03:15.084663 ignition[1384]: INFO : umount: umount passed Sep 13 00:03:15.084663 ignition[1384]: INFO : Ignition finished successfully Sep 13 00:03:15.070888 systemd[1]: iscsid.service: Deactivated successfully. Sep 13 00:03:15.071125 systemd[1]: Stopped iscsid.service. Sep 13 00:03:15.074676 systemd[1]: Stopping iscsiuio.service... Sep 13 00:03:15.096821 systemd[1]: iscsiuio.service: Deactivated successfully. Sep 13 00:03:15.097074 systemd[1]: Stopped iscsiuio.service. Sep 13 00:03:15.099000 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' Sep 13 00:03:15.102611 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 13 00:03:15.104912 systemd[1]: Finished initrd-cleanup.service. Sep 13 00:03:15.105000 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' Sep 13 00:03:15.105000 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' Sep 13 00:03:15.109079 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 13 00:03:15.111512 systemd[1]: Stopped ignition-mount.service. Sep 13 00:03:15.114000 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' Sep 13 00:03:15.115755 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 13 00:03:15.115973 systemd[1]: Stopped sysroot-boot.service. Sep 13 00:03:15.120000 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' Sep 13 00:03:15.123709 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 13 00:03:15.123853 systemd[1]: Stopped ignition-disks.service. Sep 13 00:03:15.126000 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' Sep 13 00:03:15.129886 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 13 00:03:15.130028 systemd[1]: Stopped ignition-kargs.service. Sep 13 00:03:15.131000 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' Sep 13 00:03:15.131000 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' Sep 13 00:03:15.131000 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' Sep 13 00:03:15.134438 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 13 00:03:15.134550 systemd[1]: Stopped ignition-fetch.service. Sep 13 00:03:15.163000 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' Sep 13 00:03:15.163000 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' Sep 13 00:03:15.134715 systemd[1]: Stopped target network.target. Sep 13 00:03:15.135089 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 13 00:03:15.135182 systemd[1]: Stopped ignition-fetch-offline.service. Sep 13 00:03:15.179000 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' Sep 13 00:03:15.135954 systemd[1]: Stopped target paths.target. Sep 13 00:03:15.181000 audit: BPF prog-id=6 op=UNLOAD Sep 13 00:03:15.136269 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 13 00:03:15.143484 systemd[1]: Stopped systemd-ask-password-console.path. Sep 13 00:03:15.145677 systemd[1]: Stopped target slices.target. Sep 13 00:03:15.147676 systemd[1]: Stopped target sockets.target. Sep 13 00:03:15.150853 systemd[1]: iscsid.socket: Deactivated successfully. Sep 13 00:03:15.150940 systemd[1]: Closed iscsid.socket. Sep 13 00:03:15.159066 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 13 00:03:15.159152 systemd[1]: Closed iscsiuio.socket. Sep 13 00:03:15.164790 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 13 00:03:15.164898 systemd[1]: Stopped ignition-setup.service. Sep 13 00:03:15.165926 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 13 00:03:15.166024 systemd[1]: Stopped initrd-setup-root.service. Sep 13 00:03:15.209000 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' Sep 13 00:03:15.166514 systemd[1]: Stopping systemd-networkd.service... Sep 13 00:03:15.167407 systemd[1]: Stopping systemd-resolved.service... Sep 13 00:03:15.175768 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 13 00:03:15.175981 systemd[1]: Stopped systemd-resolved.service. Sep 13 00:03:15.188791 systemd-networkd[1190]: eth0: DHCPv6 lease lost Sep 13 00:03:15.229000 audit: BPF prog-id=9 op=UNLOAD Sep 13 00:03:15.205310 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 13 00:03:15.205573 systemd[1]: Stopped systemd-networkd.service. Sep 13 00:03:15.213947 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 13 00:03:15.214020 systemd[1]: Closed systemd-networkd.socket. Sep 13 00:03:15.242048 systemd[1]: Stopping network-cleanup.service... Sep 13 00:03:15.247521 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 13 00:03:15.250000 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' Sep 13 00:03:15.252000 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' Sep 13 00:03:15.247671 systemd[1]: Stopped parse-ip-for-networkd.service. Sep 13 00:03:15.255000 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' Sep 13 00:03:15.251851 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 13 00:03:15.251959 systemd[1]: Stopped systemd-sysctl.service. Sep 13 00:03:15.256266 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 13 00:03:15.256399 systemd[1]: Stopped systemd-modules-load.service. Sep 13 00:03:15.260610 systemd[1]: Stopping systemd-udevd.service... Sep 13 00:03:15.264584 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Sep 13 00:03:15.284468 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 13 00:03:15.288000 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' Sep 13 00:03:15.286040 systemd[1]: Stopped network-cleanup.service. Sep 13 00:03:15.298082 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 13 00:03:15.300438 systemd[1]: Stopped systemd-udevd.service. Sep 13 00:03:15.299000 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' Sep 13 00:03:15.304281 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 13 00:03:15.304403 systemd[1]: Closed systemd-udevd-control.socket. Sep 13 00:03:15.312000 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' Sep 13 00:03:15.314000 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' Sep 13 00:03:15.314000 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' Sep 13 00:03:15.306795 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 13 00:03:15.326000 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' Sep 13 00:03:15.306881 systemd[1]: Closed systemd-udevd-kernel.socket. Sep 13 00:03:15.308947 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 13 00:03:15.309061 systemd[1]: Stopped dracut-pre-udev.service. Sep 13 00:03:15.314569 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 13 00:03:15.315012 systemd[1]: Stopped dracut-cmdline.service. Sep 13 00:03:15.317704 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 13 00:03:15.317809 systemd[1]: Stopped dracut-cmdline-ask.service. Sep 13 00:03:15.321287 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Sep 13 00:03:15.324846 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 13 00:03:15.324970 systemd[1]: Stopped systemd-vconsole-setup.service. Sep 13 00:03:15.356743 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 13 00:03:15.359507 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Sep 13 00:03:15.362000 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' Sep 13 00:03:15.362000 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' Sep 13 00:03:15.363853 systemd[1]: Reached target initrd-switch-root.target. Sep 13 00:03:15.369309 systemd[1]: Starting initrd-switch-root.service... Sep 13 00:03:15.386933 systemd[1]: Switching root. Sep 13 00:03:15.411388 systemd-journald[309]: Received SIGTERM from PID 1 (systemd). Sep 13 00:03:15.411487 systemd-journald[309]: Journal stopped Sep 13 00:03:23.330014 kernel: SELinux: Class mctp_socket not defined in policy. Sep 13 00:03:23.330161 kernel: SELinux: Class anon_inode not defined in policy. Sep 13 00:03:23.330199 kernel: SELinux: the above unknown classes and permissions will be allowed Sep 13 00:03:23.330233 kernel: SELinux: policy capability network_peer_controls=1 Sep 13 00:03:23.330269 kernel: SELinux: policy capability open_perms=1 Sep 13 00:03:23.330318 kernel: SELinux: policy capability extended_socket_class=1 Sep 13 00:03:23.330357 kernel: SELinux: policy capability always_check_network=0 Sep 13 00:03:23.330424 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 13 00:03:23.330461 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 13 00:03:23.330522 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 13 00:03:23.330557 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 13 00:03:23.330611 systemd[1]: Successfully loaded SELinux policy in 264.875ms. Sep 13 00:03:23.330666 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.004ms. Sep 13 00:03:23.330702 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) Sep 13 00:03:23.330738 systemd[1]: Detected virtualization amazon. Sep 13 00:03:23.336474 systemd[1]: Detected architecture arm64. Sep 13 00:03:23.336525 systemd[1]: Detected first boot. Sep 13 00:03:23.336561 systemd[1]: Initializing machine ID from VM UUID. Sep 13 00:03:23.336595 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Sep 13 00:03:23.336633 systemd[1]: Populated /etc with preset unit settings. Sep 13 00:03:23.336668 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Sep 13 00:03:23.336708 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Sep 13 00:03:23.336746 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. Sep 13 00:03:23.336782 kernel: kauditd_printk_skb: 61 callbacks suppressed Sep 13 00:03:23.336813 kernel: audit: type=1334 audit(1757721802.860:88): prog-id=12 op=LOAD Sep 13 00:03:23.336843 kernel: audit: type=1334 audit(1757721802.860:89): prog-id=3 op=UNLOAD Sep 13 00:03:23.336875 kernel: audit: type=1334 audit(1757721802.862:90): prog-id=13 op=LOAD Sep 13 00:03:23.336914 kernel: audit: type=1334 audit(1757721802.865:91): prog-id=14 op=LOAD Sep 13 00:03:23.336946 kernel: audit: type=1334 audit(1757721802.865:92): prog-id=4 op=UNLOAD Sep 13 00:03:23.336981 kernel: audit: type=1334 audit(1757721802.865:93): prog-id=5 op=UNLOAD Sep 13 00:03:23.337012 kernel: audit: type=1334 audit(1757721802.870:94): prog-id=15 op=LOAD Sep 13 00:03:23.337046 kernel: audit: type=1334 audit(1757721802.870:95): prog-id=12 op=UNLOAD Sep 13 00:03:23.337074 kernel: audit: type=1334 audit(1757721802.873:96): prog-id=16 op=LOAD Sep 13 00:03:23.337104 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 13 00:03:23.337134 kernel: audit: type=1334 audit(1757721802.876:97): prog-id=17 op=LOAD Sep 13 00:03:23.337167 systemd[1]: Stopped initrd-switch-root.service. Sep 13 00:03:23.337203 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 13 00:03:23.337237 systemd[1]: Created slice system-addon\x2dconfig.slice. Sep 13 00:03:23.337275 systemd[1]: Created slice system-addon\x2drun.slice. Sep 13 00:03:23.337310 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice. Sep 13 00:03:23.337344 systemd[1]: Created slice system-getty.slice. Sep 13 00:03:23.337410 systemd[1]: Created slice system-modprobe.slice. Sep 13 00:03:23.337447 systemd[1]: Created slice system-serial\x2dgetty.slice. Sep 13 00:03:23.337481 systemd[1]: Created slice system-system\x2dcloudinit.slice. Sep 13 00:03:23.337516 systemd[1]: Created slice system-systemd\x2dfsck.slice. Sep 13 00:03:23.337556 systemd[1]: Created slice user.slice. Sep 13 00:03:23.337588 systemd[1]: Started systemd-ask-password-console.path. Sep 13 00:03:23.337627 systemd[1]: Started systemd-ask-password-wall.path. Sep 13 00:03:23.337667 systemd[1]: Set up automount boot.automount. Sep 13 00:03:23.337699 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Sep 13 00:03:23.337729 systemd[1]: Stopped target initrd-switch-root.target. Sep 13 00:03:23.337761 systemd[1]: Stopped target initrd-fs.target. Sep 13 00:03:23.337794 systemd[1]: Stopped target initrd-root-fs.target. Sep 13 00:03:23.337826 systemd[1]: Reached target integritysetup.target. Sep 13 00:03:23.337862 systemd[1]: Reached target remote-cryptsetup.target. Sep 13 00:03:23.337895 systemd[1]: Reached target remote-fs.target. Sep 13 00:03:23.337927 systemd[1]: Reached target slices.target. Sep 13 00:03:23.337956 systemd[1]: Reached target swap.target. Sep 13 00:03:23.337986 systemd[1]: Reached target torcx.target. Sep 13 00:03:23.338016 systemd[1]: Reached target veritysetup.target. Sep 13 00:03:23.338048 systemd[1]: Listening on systemd-coredump.socket. Sep 13 00:03:23.338079 systemd[1]: Listening on systemd-initctl.socket. Sep 13 00:03:23.338111 systemd[1]: Listening on systemd-networkd.socket. Sep 13 00:03:23.338144 systemd[1]: Listening on systemd-udevd-control.socket. Sep 13 00:03:23.338179 systemd[1]: Listening on systemd-udevd-kernel.socket. Sep 13 00:03:23.338211 systemd[1]: Listening on systemd-userdbd.socket. Sep 13 00:03:23.338241 systemd[1]: Mounting dev-hugepages.mount... Sep 13 00:03:23.338273 systemd[1]: Mounting dev-mqueue.mount... Sep 13 00:03:23.338305 systemd[1]: Mounting media.mount... Sep 13 00:03:23.338340 systemd[1]: Mounting sys-kernel-debug.mount... Sep 13 00:03:23.338397 systemd[1]: Mounting sys-kernel-tracing.mount... Sep 13 00:03:23.338435 systemd[1]: Mounting tmp.mount... Sep 13 00:03:23.338466 systemd[1]: Starting flatcar-tmpfiles.service... Sep 13 00:03:23.338503 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Sep 13 00:03:23.338535 systemd[1]: Starting kmod-static-nodes.service... Sep 13 00:03:23.338568 systemd[1]: Starting modprobe@configfs.service... Sep 13 00:03:23.338598 systemd[1]: Starting modprobe@dm_mod.service... Sep 13 00:03:23.338631 systemd[1]: Starting modprobe@drm.service... Sep 13 00:03:23.338662 systemd[1]: Starting modprobe@efi_pstore.service... Sep 13 00:03:23.338695 systemd[1]: Starting modprobe@fuse.service... Sep 13 00:03:23.338726 systemd[1]: Starting modprobe@loop.service... Sep 13 00:03:23.338762 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 13 00:03:23.338800 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 13 00:03:23.338830 systemd[1]: Stopped systemd-fsck-root.service. Sep 13 00:03:23.338863 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 13 00:03:23.338893 systemd[1]: Stopped systemd-fsck-usr.service. Sep 13 00:03:23.338926 systemd[1]: Stopped systemd-journald.service. Sep 13 00:03:23.338956 systemd[1]: Starting systemd-journald.service... Sep 13 00:03:23.338986 systemd[1]: Starting systemd-modules-load.service... Sep 13 00:03:23.339016 systemd[1]: Starting systemd-network-generator.service... Sep 13 00:03:23.339050 systemd[1]: Starting systemd-remount-fs.service... Sep 13 00:03:23.339086 systemd[1]: Starting systemd-udev-trigger.service... Sep 13 00:03:23.339118 systemd[1]: verity-setup.service: Deactivated successfully. Sep 13 00:03:23.339151 systemd[1]: Stopped verity-setup.service. Sep 13 00:03:23.339183 systemd[1]: Mounted dev-hugepages.mount. Sep 13 00:03:23.339213 systemd[1]: Mounted dev-mqueue.mount. Sep 13 00:03:23.339243 systemd[1]: Mounted media.mount. Sep 13 00:03:23.339273 kernel: loop: module loaded Sep 13 00:03:23.339303 systemd[1]: Mounted sys-kernel-debug.mount. Sep 13 00:03:23.339332 systemd[1]: Mounted sys-kernel-tracing.mount. Sep 13 00:03:23.339363 systemd[1]: Mounted tmp.mount. Sep 13 00:03:23.339432 systemd[1]: Finished kmod-static-nodes.service. Sep 13 00:03:23.339465 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 13 00:03:23.339496 systemd[1]: Finished modprobe@configfs.service. Sep 13 00:03:23.339525 kernel: fuse: init (API version 7.34) Sep 13 00:03:23.339555 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 13 00:03:23.339585 systemd[1]: Finished modprobe@dm_mod.service. Sep 13 00:03:23.339616 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 13 00:03:23.339651 systemd[1]: Finished modprobe@drm.service. Sep 13 00:03:23.339691 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 13 00:03:23.339723 systemd[1]: Finished modprobe@efi_pstore.service. Sep 13 00:03:23.351607 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 13 00:03:23.351683 systemd[1]: Finished modprobe@fuse.service. Sep 13 00:03:23.351721 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 13 00:03:23.351754 systemd[1]: Finished modprobe@loop.service. Sep 13 00:03:23.351799 systemd-journald[1495]: Journal started Sep 13 00:03:23.354062 systemd-journald[1495]: Runtime Journal (/run/log/journal/ec228bb498135fffcdc00402ef628e8c) is 8.0M, max 75.4M, 67.4M free. Sep 13 00:03:16.695000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 13 00:03:17.015000 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 Sep 13 00:03:17.015000 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 Sep 13 00:03:17.015000 audit: BPF prog-id=10 op=LOAD Sep 13 00:03:17.015000 audit: BPF prog-id=10 op=UNLOAD Sep 13 00:03:17.015000 audit: BPF prog-id=11 op=LOAD Sep 13 00:03:17.015000 audit: BPF prog-id=11 op=UNLOAD Sep 13 00:03:17.562000 audit[1417]: AVC avc: denied { associate } for pid=1417 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" Sep 13 00:03:17.562000 audit[1417]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=40001458b4 a1=40000c6de0 a2=40000cd0c0 a3=32 items=0 ppid=1400 pid=1417 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) Sep 13 00:03:17.562000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Sep 13 00:03:17.566000 audit[1417]: AVC avc: denied { associate } for pid=1417 comm="torcx-generator" name="usr" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Sep 13 00:03:17.566000 audit[1417]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=4000145989 a2=1ed a3=0 items=2 ppid=1400 pid=1417 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) Sep 13 00:03:17.566000 audit: CWD cwd="/" Sep 13 00:03:17.566000 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 Sep 13 00:03:17.566000 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 Sep 13 00:03:17.566000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Sep 13 00:03:22.860000 audit: BPF prog-id=12 op=LOAD Sep 13 00:03:22.860000 audit: BPF prog-id=3 op=UNLOAD Sep 13 00:03:22.862000 audit: BPF prog-id=13 op=LOAD Sep 13 00:03:22.865000 audit: BPF prog-id=14 op=LOAD Sep 13 00:03:22.865000 audit: BPF prog-id=4 op=UNLOAD Sep 13 00:03:22.865000 audit: BPF prog-id=5 op=UNLOAD Sep 13 00:03:22.870000 audit: BPF prog-id=15 op=LOAD Sep 13 00:03:22.870000 audit: BPF prog-id=12 op=UNLOAD Sep 13 00:03:22.873000 audit: BPF prog-id=16 op=LOAD Sep 13 00:03:22.876000 audit: BPF prog-id=17 op=LOAD Sep 13 00:03:22.876000 audit: BPF prog-id=13 op=UNLOAD Sep 13 00:03:22.876000 audit: BPF prog-id=14 op=UNLOAD Sep 13 00:03:22.878000 audit: BPF prog-id=18 op=LOAD Sep 13 00:03:22.879000 audit: BPF prog-id=15 op=UNLOAD Sep 13 00:03:22.881000 audit: BPF prog-id=19 op=LOAD Sep 13 00:03:22.884000 audit: BPF prog-id=20 op=LOAD Sep 13 00:03:22.884000 audit: BPF prog-id=16 op=UNLOAD Sep 13 00:03:22.884000 audit: BPF prog-id=17 op=UNLOAD Sep 13 00:03:22.886000 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' Sep 13 00:03:22.895000 audit: BPF prog-id=18 op=UNLOAD Sep 13 00:03:22.897000 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' Sep 13 00:03:22.897000 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' Sep 13 00:03:23.174000 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' Sep 13 00:03:23.179000 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' Sep 13 00:03:23.189000 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' Sep 13 00:03:23.189000 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' Sep 13 00:03:23.193000 audit: BPF prog-id=21 op=LOAD Sep 13 00:03:23.194000 audit: BPF prog-id=22 op=LOAD Sep 13 00:03:23.195000 audit: BPF prog-id=23 op=LOAD Sep 13 00:03:23.195000 audit: BPF prog-id=19 op=UNLOAD Sep 13 00:03:23.195000 audit: BPF prog-id=20 op=UNLOAD Sep 13 00:03:23.244000 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' Sep 13 00:03:23.287000 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' Sep 13 00:03:23.297000 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' Sep 13 00:03:23.297000 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' Sep 13 00:03:23.310000 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' Sep 13 00:03:23.310000 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' Sep 13 00:03:23.368493 systemd[1]: Finished systemd-network-generator.service. Sep 13 00:03:23.368587 systemd[1]: Started systemd-journald.service. Sep 13 00:03:23.315000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Sep 13 00:03:23.315000 audit[1495]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=6 a1=fffff4935410 a2=4000 a3=1 items=0 ppid=1 pid=1495 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) Sep 13 00:03:23.315000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Sep 13 00:03:23.320000 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' Sep 13 00:03:23.320000 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' Sep 13 00:03:23.329000 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' Sep 13 00:03:23.329000 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' Sep 13 00:03:23.342000 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' Sep 13 00:03:23.342000 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' Sep 13 00:03:23.352000 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' Sep 13 00:03:23.352000 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' Sep 13 00:03:23.359000 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' Sep 13 00:03:23.364000 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' Sep 13 00:03:17.536831 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" 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.8 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.8 /var/lib/torcx/store]" Sep 13 00:03:22.858595 systemd[1]: Queued start job for default target multi-user.target. Sep 13 00:03:23.371000 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' Sep 13 00:03:17.537871 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Sep 13 00:03:22.858616 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device. Sep 13 00:03:17.537928 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Sep 13 00:03:22.886819 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 13 00:03:17.537993 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Sep 13 00:03:23.370557 systemd[1]: Finished systemd-remount-fs.service. Sep 13 00:03:17.538018 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=debug msg="skipped missing lower profile" missing profile=oem Sep 13 00:03:23.373519 systemd[1]: Reached target network-pre.target. Sep 13 00:03:17.538080 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Sep 13 00:03:17.538111 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Sep 13 00:03:17.538557 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Sep 13 00:03:17.538641 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Sep 13 00:03:23.378494 systemd[1]: Mounting sys-fs-fuse-connections.mount... Sep 13 00:03:17.538677 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Sep 13 00:03:23.383140 systemd[1]: Mounting sys-kernel-config.mount... Sep 13 00:03:17.562435 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" 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 Sep 13 00:03:23.390469 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 13 00:03:17.562575 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" 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 Sep 13 00:03:17.562631 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.8: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.8 Sep 13 00:03:17.562698 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Sep 13 00:03:17.562773 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.8: no such file or directory" path=/var/lib/torcx/store/3510.3.8 Sep 13 00:03:17.562814 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:17Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Sep 13 00:03:21.923554 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:21Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Sep 13 00:03:21.924082 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03: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 Sep 13 00:03:21.924319 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03: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 Sep 13 00:03:21.924824 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03: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 Sep 13 00:03:21.924935 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03:21Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Sep 13 00:03:21.925077 /usr/lib/systemd/system-generators/torcx-generator[1417]: time="2025-09-13T00:03: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 Sep 13 00:03:23.397740 systemd[1]: Starting systemd-hwdb-update.service... Sep 13 00:03:23.403133 systemd[1]: Starting systemd-journal-flush.service... Sep 13 00:03:23.405463 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 13 00:03:23.412517 systemd[1]: Starting systemd-random-seed.service... Sep 13 00:03:23.414630 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Sep 13 00:03:23.422050 systemd[1]: Finished systemd-modules-load.service. Sep 13 00:03:23.420000 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' Sep 13 00:03:23.424716 systemd[1]: Mounted sys-fs-fuse-connections.mount. Sep 13 00:03:23.427162 systemd[1]: Mounted sys-kernel-config.mount. Sep 13 00:03:23.432248 systemd[1]: Starting systemd-sysctl.service... Sep 13 00:03:23.461003 systemd-journald[1495]: Time spent on flushing to /var/log/journal/ec228bb498135fffcdc00402ef628e8c is 66.105ms for 1116 entries. Sep 13 00:03:23.461003 systemd-journald[1495]: System Journal (/var/log/journal/ec228bb498135fffcdc00402ef628e8c) is 8.0M, max 195.6M, 187.6M free. Sep 13 00:03:23.543943 systemd-journald[1495]: Received client request to flush runtime journal. Sep 13 00:03:23.472000 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' Sep 13 00:03:23.507000 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' Sep 13 00:03:23.544000 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' Sep 13 00:03:23.470959 systemd[1]: Finished systemd-random-seed.service. Sep 13 00:03:23.473312 systemd[1]: Reached target first-boot-complete.target. Sep 13 00:03:23.506618 systemd[1]: Finished systemd-sysctl.service. Sep 13 00:03:23.545594 systemd[1]: Finished systemd-journal-flush.service. Sep 13 00:03:23.554915 systemd[1]: Finished flatcar-tmpfiles.service. Sep 13 00:03:23.553000 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' Sep 13 00:03:23.560778 systemd[1]: Starting systemd-sysusers.service... Sep 13 00:03:23.621824 systemd[1]: Finished systemd-udev-trigger.service. Sep 13 00:03:23.622000 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' Sep 13 00:03:23.626480 systemd[1]: Starting systemd-udev-settle.service... Sep 13 00:03:23.643546 udevadm[1536]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Sep 13 00:03:23.776077 systemd[1]: Finished systemd-sysusers.service. Sep 13 00:03:23.776000 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' Sep 13 00:03:24.374123 systemd[1]: Finished systemd-hwdb-update.service. Sep 13 00:03:24.376000 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' Sep 13 00:03:24.377000 audit: BPF prog-id=24 op=LOAD Sep 13 00:03:24.377000 audit: BPF prog-id=25 op=LOAD Sep 13 00:03:24.377000 audit: BPF prog-id=7 op=UNLOAD Sep 13 00:03:24.377000 audit: BPF prog-id=8 op=UNLOAD Sep 13 00:03:24.380211 systemd[1]: Starting systemd-udevd.service... Sep 13 00:03:24.422845 systemd-udevd[1537]: Using default interface naming scheme 'v252'. Sep 13 00:03:24.482614 systemd[1]: Started systemd-udevd.service. Sep 13 00:03:24.483000 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' Sep 13 00:03:24.487000 audit: BPF prog-id=26 op=LOAD Sep 13 00:03:24.489938 systemd[1]: Starting systemd-networkd.service... Sep 13 00:03:24.499000 audit: BPF prog-id=27 op=LOAD Sep 13 00:03:24.499000 audit: BPF prog-id=28 op=LOAD Sep 13 00:03:24.500000 audit: BPF prog-id=29 op=LOAD Sep 13 00:03:24.503000 systemd[1]: Starting systemd-userdbd.service... Sep 13 00:03:24.597734 systemd[1]: Condition check resulted in dev-ttyS0.device being skipped. Sep 13 00:03:24.601979 (udev-worker)[1546]: Network interface NamePolicy= disabled on kernel command line. Sep 13 00:03:24.623123 systemd[1]: Started systemd-userdbd.service. Sep 13 00:03:24.625000 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' Sep 13 00:03:24.843463 systemd-networkd[1540]: lo: Link UP Sep 13 00:03:24.844055 systemd-networkd[1540]: lo: Gained carrier Sep 13 00:03:24.845350 systemd-networkd[1540]: Enumeration completed Sep 13 00:03:24.845916 systemd[1]: Started systemd-networkd.service. Sep 13 00:03:24.846598 systemd-networkd[1540]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 13 00:03:24.847000 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' Sep 13 00:03:24.852711 systemd[1]: Starting systemd-networkd-wait-online.service... Sep 13 00:03:24.863189 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Sep 13 00:03:24.862206 systemd-networkd[1540]: eth0: Link UP Sep 13 00:03:24.862612 systemd-networkd[1540]: eth0: Gained carrier Sep 13 00:03:24.892739 systemd-networkd[1540]: eth0: DHCPv4 address 172.31.27.4/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 13 00:03:25.054890 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Sep 13 00:03:25.058159 systemd[1]: Finished systemd-udev-settle.service. Sep 13 00:03:25.059000 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' Sep 13 00:03:25.063044 systemd[1]: Starting lvm2-activation-early.service... Sep 13 00:03:25.127880 lvm[1656]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 13 00:03:25.171564 systemd[1]: Finished lvm2-activation-early.service. Sep 13 00:03:25.172000 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' Sep 13 00:03:25.174234 systemd[1]: Reached target cryptsetup.target. Sep 13 00:03:25.178718 systemd[1]: Starting lvm2-activation.service... Sep 13 00:03:25.188165 lvm[1657]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 13 00:03:25.228283 systemd[1]: Finished lvm2-activation.service. Sep 13 00:03:25.229000 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' Sep 13 00:03:25.230624 systemd[1]: Reached target local-fs-pre.target. Sep 13 00:03:25.232783 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 13 00:03:25.232853 systemd[1]: Reached target local-fs.target. Sep 13 00:03:25.235059 systemd[1]: Reached target machines.target. Sep 13 00:03:25.239700 systemd[1]: Starting ldconfig.service... Sep 13 00:03:25.242716 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Sep 13 00:03:25.243054 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). Sep 13 00:03:25.245627 systemd[1]: Starting systemd-boot-update.service... Sep 13 00:03:25.250513 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Sep 13 00:03:25.259820 systemd[1]: Starting systemd-machine-id-commit.service... Sep 13 00:03:25.262100 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Sep 13 00:03:25.262251 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Sep 13 00:03:25.265134 systemd[1]: Starting systemd-tmpfiles-setup.service... Sep 13 00:03:25.273835 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1659 (bootctl) Sep 13 00:03:25.277028 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Sep 13 00:03:25.314030 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 13 00:03:25.315000 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' Sep 13 00:03:25.316464 systemd[1]: Finished systemd-machine-id-commit.service. Sep 13 00:03:25.331925 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Sep 13 00:03:25.330000 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' Sep 13 00:03:25.352927 systemd-tmpfiles[1662]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Sep 13 00:03:25.390079 systemd-tmpfiles[1662]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 13 00:03:25.425437 systemd-fsck[1667]: fsck.fat 4.2 (2021-01-31) Sep 13 00:03:25.425437 systemd-fsck[1667]: /dev/nvme0n1p1: 236 files, 117310/258078 clusters Sep 13 00:03:25.428837 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Sep 13 00:03:25.431000 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' Sep 13 00:03:25.433865 systemd-tmpfiles[1662]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 13 00:03:25.435365 systemd[1]: Mounting boot.mount... Sep 13 00:03:25.459050 systemd[1]: Mounted boot.mount. Sep 13 00:03:25.488061 systemd[1]: Finished systemd-boot-update.service. Sep 13 00:03:25.489000 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' Sep 13 00:03:25.816873 systemd[1]: Finished systemd-tmpfiles-setup.service. Sep 13 00:03:25.818000 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' Sep 13 00:03:25.822225 systemd[1]: Starting audit-rules.service... Sep 13 00:03:25.827136 systemd[1]: Starting clean-ca-certificates.service... Sep 13 00:03:25.832163 systemd[1]: Starting systemd-journal-catalog-update.service... Sep 13 00:03:25.843000 audit: BPF prog-id=30 op=LOAD Sep 13 00:03:25.847162 systemd[1]: Starting systemd-resolved.service... Sep 13 00:03:25.849000 audit: BPF prog-id=31 op=LOAD Sep 13 00:03:25.854752 systemd[1]: Starting systemd-timesyncd.service... Sep 13 00:03:25.861466 systemd[1]: Starting systemd-update-utmp.service... Sep 13 00:03:25.870000 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' Sep 13 00:03:25.869829 systemd[1]: Finished clean-ca-certificates.service. Sep 13 00:03:25.872520 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 13 00:03:25.888000 audit[1686]: SYSTEM_BOOT pid=1686 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' Sep 13 00:03:25.896000 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' Sep 13 00:03:25.895434 systemd[1]: Finished systemd-update-utmp.service. Sep 13 00:03:25.954188 systemd[1]: Finished systemd-journal-catalog-update.service. Sep 13 00:03:25.955000 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' Sep 13 00:03:26.015000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-timesyncd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:26.014674 systemd[1]: Started systemd-timesyncd.service. Sep 13 00:03:26.016962 systemd[1]: Reached target time-set.target. Sep 13 00:03:26.025000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Sep 13 00:03:26.025000 audit[1701]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe3d75b90 a2=420 a3=0 items=0 ppid=1681 pid=1701 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) Sep 13 00:03:26.025000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 13 00:03:26.027639 augenrules[1701]: No rules Sep 13 00:03:26.028399 systemd[1]: Finished audit-rules.service. Sep 13 00:03:26.034200 systemd-resolved[1684]: Positive Trust Anchors: Sep 13 00:03:26.034227 systemd-resolved[1684]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 13 00:03:26.034279 systemd-resolved[1684]: 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 Sep 13 00:03:26.094548 systemd-resolved[1684]: Defaulting to hostname 'linux'. Sep 13 00:03:26.099504 systemd[1]: Started systemd-resolved.service. Sep 13 00:03:26.101607 systemd[1]: Reached target network.target. Sep 13 00:03:26.103485 systemd[1]: Reached target nss-lookup.target. Sep 13 00:03:26.106745 systemd-timesyncd[1685]: Contacted time server 50.205.57.38:123 (0.flatcar.pool.ntp.org). Sep 13 00:03:26.107508 systemd-timesyncd[1685]: Initial clock synchronization to Sat 2025-09-13 00:03:26.171328 UTC. Sep 13 00:03:26.426637 systemd-networkd[1540]: eth0: Gained IPv6LL Sep 13 00:03:26.429677 systemd[1]: Finished systemd-networkd-wait-online.service. Sep 13 00:03:26.432189 systemd[1]: Reached target network-online.target. Sep 13 00:03:26.820533 ldconfig[1658]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 13 00:03:26.827426 systemd[1]: Finished ldconfig.service. Sep 13 00:03:26.831886 systemd[1]: Starting systemd-update-done.service... Sep 13 00:03:26.848604 systemd[1]: Finished systemd-update-done.service. Sep 13 00:03:26.851044 systemd[1]: Reached target sysinit.target. Sep 13 00:03:26.853188 systemd[1]: Started motdgen.path. Sep 13 00:03:26.855851 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Sep 13 00:03:26.859565 systemd[1]: Created slice system-user\x2dcloudinit.slice. Sep 13 00:03:26.863061 systemd[1]: Started logrotate.timer. Sep 13 00:03:26.865060 systemd[1]: Started mdadm.timer. Sep 13 00:03:26.866697 systemd[1]: Started systemd-tmpfiles-clean.timer. Sep 13 00:03:26.869009 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 13 00:03:26.869280 systemd[1]: Reached target paths.target. Sep 13 00:03:26.871307 systemd[1]: Reached target timers.target. Sep 13 00:03:26.874489 systemd[1]: Listening on dbus.socket. Sep 13 00:03:26.879045 systemd[1]: Starting docker.socket... Sep 13 00:03:26.887567 systemd[1]: Listening on sshd.socket. Sep 13 00:03:26.890005 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). Sep 13 00:03:26.891350 systemd[1]: Listening on docker.socket. Sep 13 00:03:26.893834 systemd[1]: Reached target sockets.target. Sep 13 00:03:26.896032 systemd[1]: Reached target basic.target. Sep 13 00:03:26.898305 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Sep 13 00:03:26.898642 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Sep 13 00:03:26.901198 systemd[1]: Started amazon-ssm-agent.service. Sep 13 00:03:26.908597 systemd[1]: Starting containerd.service... Sep 13 00:03:26.915101 systemd[1]: Starting coreos-metadata-sshkeys@core.service... Sep 13 00:03:26.926572 systemd[1]: Starting dbus.service... Sep 13 00:03:26.933948 systemd[1]: Starting enable-oem-cloudinit.service... Sep 13 00:03:26.939547 systemd[1]: Starting extend-filesystems.service... Sep 13 00:03:26.944650 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Sep 13 00:03:26.949775 systemd[1]: Starting motdgen.service... Sep 13 00:03:26.963441 systemd[1]: Started nvidia.service. Sep 13 00:03:26.970217 systemd[1]: Starting ssh-key-proc-cmdline.service... Sep 13 00:03:26.976711 systemd[1]: Starting sshd-keygen.service... Sep 13 00:03:26.994229 systemd[1]: Starting systemd-logind.service... Sep 13 00:03:26.996332 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Sep 13 00:03:26.996753 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 13 00:03:26.997789 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 13 00:03:26.999846 systemd[1]: Starting update-engine.service... Sep 13 00:03:27.005635 systemd[1]: Starting update-ssh-keys-after-ignition.service... Sep 13 00:03:27.047358 jq[1724]: true Sep 13 00:03:27.057035 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 13 00:03:27.086515 jq[1715]: false Sep 13 00:03:27.057486 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Sep 13 00:03:27.065263 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 13 00:03:27.065630 systemd[1]: Finished ssh-key-proc-cmdline.service. Sep 13 00:03:27.129904 jq[1733]: true Sep 13 00:03:27.183063 extend-filesystems[1716]: Found nvme0n1 Sep 13 00:03:27.194445 extend-filesystems[1716]: Found nvme0n1p1 Sep 13 00:03:27.198100 extend-filesystems[1716]: Found nvme0n1p2 Sep 13 00:03:27.202700 extend-filesystems[1716]: Found nvme0n1p3 Sep 13 00:03:27.206322 extend-filesystems[1716]: Found usr Sep 13 00:03:27.209451 extend-filesystems[1716]: Found nvme0n1p4 Sep 13 00:03:27.215999 extend-filesystems[1716]: Found nvme0n1p6 Sep 13 00:03:27.219318 extend-filesystems[1716]: Found nvme0n1p7 Sep 13 00:03:27.223259 systemd[1]: motdgen.service: Deactivated successfully. Sep 13 00:03:27.223712 systemd[1]: Finished motdgen.service. Sep 13 00:03:27.233272 extend-filesystems[1716]: Found nvme0n1p9 Sep 13 00:03:27.238668 extend-filesystems[1716]: Checking size of /dev/nvme0n1p9 Sep 13 00:03:27.246161 dbus-daemon[1713]: [system] SELinux support is enabled Sep 13 00:03:27.246519 systemd[1]: Started dbus.service. Sep 13 00:03:27.252186 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). Sep 13 00:03:27.252244 systemd[1]: Reached target system-config.target. Sep 13 00:03:27.254499 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 13 00:03:27.258009 systemd[1]: Starting user-cloudinit@var-lib-flatcar\x2dinstall-user_data.service... Sep 13 00:03:27.281800 dbus-daemon[1713]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1540 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Sep 13 00:03:27.289948 dbus-daemon[1713]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 13 00:03:27.297801 systemd[1]: Starting systemd-hostnamed.service... Sep 13 00:03:27.355526 extend-filesystems[1716]: Resized partition /dev/nvme0n1p9 Sep 13 00:03:27.383461 extend-filesystems[1774]: resize2fs 1.46.5 (30-Dec-2021) Sep 13 00:03:27.408049 bash[1773]: Updated "/home/core/.ssh/authorized_keys" Sep 13 00:03:27.416581 systemd[1]: Finished update-ssh-keys-after-ignition.service. Sep 13 00:03:27.436423 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Sep 13 00:03:27.485108 update_engine[1723]: I0913 00:03:27.484568 1723 main.cc:92] Flatcar Update Engine starting Sep 13 00:03:27.491181 systemd[1]: Started update-engine.service. Sep 13 00:03:27.501734 update_engine[1723]: I0913 00:03:27.491281 1723 update_check_scheduler.cc:74] Next update check in 5m49s Sep 13 00:03:27.496685 systemd[1]: Started locksmithd.service. Sep 13 00:03:27.516283 amazon-ssm-agent[1710]: 2025/09/13 00:03:27 Failed to load instance info from vault. RegistrationKey does not exist. Sep 13 00:03:27.525416 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Sep 13 00:03:27.540519 extend-filesystems[1774]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Sep 13 00:03:27.540519 extend-filesystems[1774]: old_desc_blocks = 1, new_desc_blocks = 1 Sep 13 00:03:27.540519 extend-filesystems[1774]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Sep 13 00:03:27.552133 amazon-ssm-agent[1710]: Initializing new seelog logger Sep 13 00:03:27.552133 amazon-ssm-agent[1710]: New Seelog Logger Creation Complete Sep 13 00:03:27.552133 amazon-ssm-agent[1710]: 2025/09/13 00:03:27 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 13 00:03:27.552133 amazon-ssm-agent[1710]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 13 00:03:27.552133 amazon-ssm-agent[1710]: 2025/09/13 00:03:27 processing appconfig overrides Sep 13 00:03:27.552861 extend-filesystems[1716]: Resized filesystem in /dev/nvme0n1p9 Sep 13 00:03:27.556866 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 13 00:03:27.557309 systemd[1]: Finished extend-filesystems.service. Sep 13 00:03:27.613351 systemd[1]: nvidia.service: Deactivated successfully. Sep 13 00:03:27.650211 systemd-logind[1722]: Watching system buttons on /dev/input/event0 (Power Button) Sep 13 00:03:27.650282 systemd-logind[1722]: Watching system buttons on /dev/input/event1 (Sleep Button) Sep 13 00:03:27.661749 systemd-logind[1722]: New seat seat0. Sep 13 00:03:27.667791 systemd[1]: Started systemd-logind.service. Sep 13 00:03:27.710629 env[1726]: time="2025-09-13T00:03:27.709734791Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Sep 13 00:03:27.731199 coreos-cloudinit[1758]: 2025/09/13 00:03:27 Checking availability of "local-file" Sep 13 00:03:27.731708 coreos-cloudinit[1758]: 2025/09/13 00:03:27 Fetching user-data from datasource of type "local-file" Sep 13 00:03:27.732356 coreos-cloudinit[1758]: 2025/09/13 00:03:27 Fetching meta-data from datasource of type "local-file" Sep 13 00:03:27.732551 coreos-cloudinit[1758]: 2025/09/13 00:03:27 Parsing user-data as cloud-config Sep 13 00:03:27.732625 coreos-cloudinit[1758]: 2025/09/13 00:03:27 Merging cloud-config from meta-data and user-data Sep 13 00:03:27.896824 dbus-daemon[1713]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 13 00:03:27.897172 systemd[1]: Started systemd-hostnamed.service. Sep 13 00:03:27.901791 dbus-daemon[1713]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=1766 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Sep 13 00:03:27.907730 systemd[1]: Starting polkit.service... Sep 13 00:03:27.913954 systemd-hostnamed[1766]: Hostname set to (static) Sep 13 00:03:27.914959 systemd-resolved[1684]: System hostname changed to 'cloud-config-worked'. Sep 13 00:03:27.919906 coreos-cloudinit[1758]: 2025/09/13 00:03:27 Set hostname to cloud-config-worked Sep 13 00:03:27.920059 coreos-cloudinit[1758]: 2025/09/13 00:03:27 Ensuring runtime unit file "etcd.service" is unmasked Sep 13 00:03:27.920059 coreos-cloudinit[1758]: 2025/09/13 00:03:27 Ensuring runtime unit file "etcd2.service" is unmasked Sep 13 00:03:27.920059 coreos-cloudinit[1758]: 2025/09/13 00:03:27 Ensuring runtime unit file "fleet.service" is unmasked Sep 13 00:03:27.920059 coreos-cloudinit[1758]: 2025/09/13 00:03:27 Ensuring runtime unit file "locksmithd.service" is unmasked Sep 13 00:03:27.922049 systemd[1]: Finished user-cloudinit@var-lib-flatcar\x2dinstall-user_data.service. Sep 13 00:03:27.925744 systemd[1]: Reached target user-config.target. Sep 13 00:03:27.933624 env[1726]: time="2025-09-13T00:03:27.933545214Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 13 00:03:27.934573 env[1726]: time="2025-09-13T00:03:27.934518393Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 13 00:03:27.941819 env[1726]: time="2025-09-13T00:03:27.941740039Z" 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.192-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 13 00:03:27.942042 env[1726]: time="2025-09-13T00:03:27.941998422Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 13 00:03:27.942690 env[1726]: time="2025-09-13T00:03:27.942621559Z" 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 Sep 13 00:03:27.942918 env[1726]: time="2025-09-13T00:03:27.942871086Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 13 00:03:27.943095 env[1726]: time="2025-09-13T00:03:27.943052967Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Sep 13 00:03:27.943263 env[1726]: time="2025-09-13T00:03:27.943229174Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 13 00:03:27.943680 env[1726]: time="2025-09-13T00:03:27.943630364Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 13 00:03:27.944680 env[1726]: time="2025-09-13T00:03:27.944614660Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 13 00:03:27.950890 env[1726]: time="2025-09-13T00:03:27.950814279Z" 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 Sep 13 00:03:27.953637 env[1726]: time="2025-09-13T00:03:27.953578587Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 13 00:03:27.953995 env[1726]: time="2025-09-13T00:03:27.953945953Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Sep 13 00:03:27.954190 env[1726]: time="2025-09-13T00:03:27.954153044Z" level=info msg="metadata content store policy set" policy=shared Sep 13 00:03:27.958466 polkitd[1835]: Started polkitd version 121 Sep 13 00:03:27.965315 env[1726]: time="2025-09-13T00:03:27.964125920Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 13 00:03:27.965315 env[1726]: time="2025-09-13T00:03:27.964257211Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 13 00:03:27.965315 env[1726]: time="2025-09-13T00:03:27.964296091Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 13 00:03:27.965315 env[1726]: time="2025-09-13T00:03:27.964444414Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 13 00:03:27.965315 env[1726]: time="2025-09-13T00:03:27.964627311Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 13 00:03:27.965315 env[1726]: time="2025-09-13T00:03:27.964693325Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 13 00:03:27.965315 env[1726]: time="2025-09-13T00:03:27.964732387Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 13 00:03:27.966269 env[1726]: time="2025-09-13T00:03:27.966200351Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 13 00:03:27.966528 env[1726]: time="2025-09-13T00:03:27.966462485Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Sep 13 00:03:27.966796 env[1726]: time="2025-09-13T00:03:27.966651684Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 13 00:03:27.966796 env[1726]: time="2025-09-13T00:03:27.966702056Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 13 00:03:27.966796 env[1726]: time="2025-09-13T00:03:27.966738421Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 13 00:03:27.967365 env[1726]: time="2025-09-13T00:03:27.967308438Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 13 00:03:27.967922 env[1726]: time="2025-09-13T00:03:27.967866334Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 13 00:03:27.968961 env[1726]: time="2025-09-13T00:03:27.968902516Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 13 00:03:27.969204 env[1726]: time="2025-09-13T00:03:27.969164056Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.969366 env[1726]: time="2025-09-13T00:03:27.969328081Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 13 00:03:27.969935 env[1726]: time="2025-09-13T00:03:27.969794632Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.970527 env[1726]: time="2025-09-13T00:03:27.970481484Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.971200 env[1726]: time="2025-09-13T00:03:27.971145968Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.973530 env[1726]: time="2025-09-13T00:03:27.971373733Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.973776 env[1726]: time="2025-09-13T00:03:27.973729108Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.973946 env[1726]: time="2025-09-13T00:03:27.973906840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.974114 env[1726]: time="2025-09-13T00:03:27.974075558Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.974306 env[1726]: time="2025-09-13T00:03:27.974266403Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.976489 env[1726]: time="2025-09-13T00:03:27.976401792Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 13 00:03:27.977051 env[1726]: time="2025-09-13T00:03:27.976996475Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.977329 env[1726]: time="2025-09-13T00:03:27.977286625Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.977552 env[1726]: time="2025-09-13T00:03:27.977516641Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.977692 env[1726]: time="2025-09-13T00:03:27.977657609Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 13 00:03:27.977850 env[1726]: time="2025-09-13T00:03:27.977809392Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Sep 13 00:03:27.977981 env[1726]: time="2025-09-13T00:03:27.977946283Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 13 00:03:27.978145 env[1726]: time="2025-09-13T00:03:27.978100546Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Sep 13 00:03:27.978343 env[1726]: time="2025-09-13T00:03:27.978303052Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 13 00:03:27.979045 env[1726]: time="2025-09-13T00:03:27.978911635Z" 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}" Sep 13 00:03:27.981185 env[1726]: time="2025-09-13T00:03:27.981128462Z" level=info msg="Connect containerd service" Sep 13 00:03:27.981486 env[1726]: time="2025-09-13T00:03:27.981439927Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 13 00:03:27.983085 env[1726]: time="2025-09-13T00:03:27.983010064Z" 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" Sep 13 00:03:27.989009 env[1726]: time="2025-09-13T00:03:27.988933336Z" level=info msg="Start subscribing containerd event" Sep 13 00:03:27.989549 env[1726]: time="2025-09-13T00:03:27.989492575Z" level=info msg="Start recovering state" Sep 13 00:03:27.991633 env[1726]: time="2025-09-13T00:03:27.991575026Z" level=info msg="Start event monitor" Sep 13 00:03:27.991875 env[1726]: time="2025-09-13T00:03:27.991833192Z" level=info msg="Start snapshots syncer" Sep 13 00:03:27.992029 env[1726]: time="2025-09-13T00:03:27.991990491Z" level=info msg="Start cni network conf syncer for default" Sep 13 00:03:27.992182 env[1726]: time="2025-09-13T00:03:27.992145613Z" level=info msg="Start streaming server" Sep 13 00:03:27.993199 env[1726]: time="2025-09-13T00:03:27.993136260Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 13 00:03:27.993595 env[1726]: time="2025-09-13T00:03:27.993545555Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 13 00:03:27.993991 systemd[1]: Started containerd.service. Sep 13 00:03:27.997238 env[1726]: time="2025-09-13T00:03:27.997193244Z" level=info msg="containerd successfully booted in 0.313332s" Sep 13 00:03:28.001994 polkitd[1835]: Loading rules from directory /etc/polkit-1/rules.d Sep 13 00:03:28.002133 polkitd[1835]: Loading rules from directory /usr/share/polkit-1/rules.d Sep 13 00:03:28.012187 polkitd[1835]: Finished loading, compiling and executing 2 rules Sep 13 00:03:28.013354 dbus-daemon[1713]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 13 00:03:28.013669 systemd[1]: Started polkit.service. Sep 13 00:03:28.016902 polkitd[1835]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Sep 13 00:03:28.095711 coreos-metadata[1712]: Sep 13 00:03:28.095 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 13 00:03:28.097404 coreos-metadata[1712]: Sep 13 00:03:28.097 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys: Attempt #1 Sep 13 00:03:28.098449 coreos-metadata[1712]: Sep 13 00:03:28.098 INFO Fetch successful Sep 13 00:03:28.098574 coreos-metadata[1712]: Sep 13 00:03:28.098 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys/0/openssh-key: Attempt #1 Sep 13 00:03:28.100166 coreos-metadata[1712]: Sep 13 00:03:28.100 INFO Fetch successful Sep 13 00:03:28.102658 unknown[1712]: wrote ssh authorized keys file for user: core Sep 13 00:03:28.134978 update-ssh-keys[1870]: Updated "/home/core/.ssh/authorized_keys" Sep 13 00:03:28.146918 systemd[1]: Finished coreos-metadata-sshkeys@core.service. Sep 13 00:03:28.242480 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Create new startup processor Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [LongRunningPluginsManager] registered plugins: {} Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Initializing bookkeeping folders Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO removing the completed state files Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Initializing bookkeeping folders for long running plugins Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Initializing replies folder for MDS reply requests that couldn't reach the service Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Initializing healthcheck folders for long running plugins Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Initializing locations for inventory plugin Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Initializing default location for custom inventory Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Initializing default location for file inventory Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Initializing default location for role inventory Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Init the cloudwatchlogs publisher Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Successfully loaded platform independent plugin aws:updateSsmAgent Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Successfully loaded platform independent plugin aws:configureDocker Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Successfully loaded platform independent plugin aws:configurePackage Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Successfully loaded platform independent plugin aws:runDocument Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Successfully loaded platform independent plugin aws:softwareInventory Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Successfully loaded platform independent plugin aws:runPowerShellScript Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Successfully loaded platform independent plugin aws:runDockerAction Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Successfully loaded platform independent plugin aws:refreshAssociation Sep 13 00:03:28.251758 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Successfully loaded platform independent plugin aws:downloadContent Sep 13 00:03:28.252933 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Successfully loaded platform dependent plugin aws:runShellScript Sep 13 00:03:28.252933 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO Starting Agent: amazon-ssm-agent - v2.3.1319.0 Sep 13 00:03:28.252933 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO OS: linux, Arch: arm64 Sep 13 00:03:28.252933 amazon-ssm-agent[1710]: datastore file /var/lib/amazon/ssm/i-0159208ef8852eef2/longrunningplugins/datastore/store doesn't exist - no long running plugins to execute Sep 13 00:03:28.352878 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessageGatewayService] Starting session document processing engine... Sep 13 00:03:28.452586 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessageGatewayService] [EngineProcessor] Starting Sep 13 00:03:28.546845 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessageGatewayService] SSM Agent is trying to setup control channel for Session Manager module. Sep 13 00:03:28.585897 locksmithd[1788]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 13 00:03:28.641748 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessageGatewayService] Setting up websocket for controlchannel for instance: i-0159208ef8852eef2, requestId: 242c5a1d-6c7f-46b4-bbe2-7dd470fa53ac Sep 13 00:03:28.736627 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [OfflineService] Starting document processing engine... Sep 13 00:03:28.832177 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [OfflineService] [EngineProcessor] Starting Sep 13 00:03:28.927329 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [OfflineService] [EngineProcessor] Initial processing Sep 13 00:03:29.022888 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [OfflineService] Starting message polling Sep 13 00:03:29.118355 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [OfflineService] Starting send replies to MDS Sep 13 00:03:29.214168 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [LongRunningPluginsManager] starting long running plugin manager Sep 13 00:03:29.310143 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [LongRunningPluginsManager] there aren't any long running plugin to execute Sep 13 00:03:29.406592 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [HealthCheck] HealthCheck reporting agent health. Sep 13 00:03:29.502903 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [LongRunningPluginsManager] There are no long running plugins currently getting executed - skipping their healthcheck Sep 13 00:03:29.599667 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessagingDeliveryService] Starting document processing engine... Sep 13 00:03:29.696308 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessagingDeliveryService] [EngineProcessor] Starting Sep 13 00:03:29.793283 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessagingDeliveryService] [EngineProcessor] Initial processing Sep 13 00:03:29.890461 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessagingDeliveryService] Starting message polling Sep 13 00:03:29.987695 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessagingDeliveryService] Starting send replies to MDS Sep 13 00:03:30.085189 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [instanceID=i-0159208ef8852eef2] Starting association polling Sep 13 00:03:30.183482 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessagingDeliveryService] [Association] [EngineProcessor] Starting Sep 13 00:03:30.281330 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessagingDeliveryService] [Association] Launching response handler Sep 13 00:03:30.379597 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessagingDeliveryService] [Association] [EngineProcessor] Initial processing Sep 13 00:03:30.478400 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessagingDeliveryService] [Association] Initializing association scheduling service Sep 13 00:03:30.576825 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessagingDeliveryService] [Association] Association scheduling service initialized Sep 13 00:03:30.675688 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessageGatewayService] listening reply. Sep 13 00:03:30.774979 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [StartupProcessor] Executing startup processor tasks Sep 13 00:03:30.874333 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [StartupProcessor] Write to serial port: Amazon SSM Agent v2.3.1319.0 is running Sep 13 00:03:30.973663 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [StartupProcessor] Write to serial port: OsProductName: Flatcar Container Linux by Kinvolk Sep 13 00:03:31.073209 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [StartupProcessor] Write to serial port: OsVersion: 3510.3.8 Sep 13 00:03:31.173128 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessageGatewayService] Opening websocket connection to: wss://ssmmessages.us-west-2.amazonaws.com/v1/control-channel/i-0159208ef8852eef2?role=subscribe&stream=input Sep 13 00:03:31.273141 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessageGatewayService] Successfully opened websocket connection to: wss://ssmmessages.us-west-2.amazonaws.com/v1/control-channel/i-0159208ef8852eef2?role=subscribe&stream=input Sep 13 00:03:31.373333 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessageGatewayService] Starting receiving message from control channel Sep 13 00:03:31.473719 amazon-ssm-agent[1710]: 2025-09-13 00:03:28 INFO [MessageGatewayService] [EngineProcessor] Initial processing Sep 13 00:03:31.928273 sshd_keygen[1746]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 13 00:03:31.970201 systemd[1]: Finished sshd-keygen.service. Sep 13 00:03:31.975736 systemd[1]: Starting issuegen.service... Sep 13 00:03:31.988742 systemd[1]: issuegen.service: Deactivated successfully. Sep 13 00:03:31.989172 systemd[1]: Finished issuegen.service. Sep 13 00:03:31.994284 systemd[1]: Starting systemd-user-sessions.service... Sep 13 00:03:32.013277 systemd[1]: Finished systemd-user-sessions.service. Sep 13 00:03:32.018719 systemd[1]: Started getty@tty1.service. Sep 13 00:03:32.024159 systemd[1]: Started serial-getty@ttyS0.service. Sep 13 00:03:32.026787 systemd[1]: Reached target getty.target. Sep 13 00:03:32.028854 systemd[1]: Reached target multi-user.target. Sep 13 00:03:32.033761 systemd[1]: Starting systemd-update-utmp-runlevel.service... Sep 13 00:03:32.051968 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Sep 13 00:03:32.052457 systemd[1]: Finished systemd-update-utmp-runlevel.service. Sep 13 00:03:32.055096 systemd[1]: Startup finished in 1.346s (kernel) + 7.788s (initrd) + 15.660s (userspace) = 24.795s. Sep 13 00:03:36.093072 systemd[1]: Created slice system-sshd.slice. Sep 13 00:03:36.095518 systemd[1]: Started sshd@0-172.31.27.4:22-139.178.89.65:43888.service. Sep 13 00:03:36.445738 sshd[1925]: Accepted publickey for core from 139.178.89.65 port 43888 ssh2: RSA SHA256:hZ9iVout2PrR+GbvdOVRihMPHc0rDrYOM1fRKHgWdwM Sep 13 00:03:36.451108 sshd[1925]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 13 00:03:36.473662 systemd[1]: Created slice user-500.slice. Sep 13 00:03:36.478931 systemd[1]: Starting user-runtime-dir@500.service... Sep 13 00:03:36.484041 systemd-logind[1722]: New session 1 of user core. Sep 13 00:03:36.497017 systemd[1]: Finished user-runtime-dir@500.service. Sep 13 00:03:36.500009 systemd[1]: Starting user@500.service... Sep 13 00:03:36.509121 (systemd)[1928]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 13 00:03:36.705025 systemd[1928]: Queued start job for default target default.target. Sep 13 00:03:36.707714 systemd[1928]: Reached target paths.target. Sep 13 00:03:36.707971 systemd[1928]: Reached target sockets.target. Sep 13 00:03:36.708122 systemd[1928]: Reached target timers.target. Sep 13 00:03:36.708283 systemd[1928]: Reached target basic.target. Sep 13 00:03:36.708546 systemd[1928]: Reached target default.target. Sep 13 00:03:36.708650 systemd[1]: Started user@500.service. Sep 13 00:03:36.710489 systemd[1928]: Startup finished in 189ms. Sep 13 00:03:36.710656 systemd[1]: Started session-1.scope. Sep 13 00:03:36.866593 systemd[1]: Started sshd@1-172.31.27.4:22-139.178.89.65:43896.service. Sep 13 00:03:37.038124 sshd[1937]: Accepted publickey for core from 139.178.89.65 port 43896 ssh2: RSA SHA256:hZ9iVout2PrR+GbvdOVRihMPHc0rDrYOM1fRKHgWdwM Sep 13 00:03:37.041124 sshd[1937]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 13 00:03:37.047912 systemd-logind[1722]: New session 2 of user core. Sep 13 00:03:37.049892 systemd[1]: Started session-2.scope. Sep 13 00:03:37.195539 sshd[1937]: pam_unix(sshd:session): session closed for user core Sep 13 00:03:37.200739 systemd-logind[1722]: Session 2 logged out. Waiting for processes to exit. Sep 13 00:03:37.201307 systemd[1]: sshd@1-172.31.27.4:22-139.178.89.65:43896.service: Deactivated successfully. Sep 13 00:03:37.202586 systemd[1]: session-2.scope: Deactivated successfully. Sep 13 00:03:37.204196 systemd-logind[1722]: Removed session 2. Sep 13 00:03:37.223261 systemd[1]: Started sshd@2-172.31.27.4:22-139.178.89.65:43906.service. Sep 13 00:03:37.399126 sshd[1943]: Accepted publickey for core from 139.178.89.65 port 43906 ssh2: RSA SHA256:hZ9iVout2PrR+GbvdOVRihMPHc0rDrYOM1fRKHgWdwM Sep 13 00:03:37.402028 sshd[1943]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 13 00:03:37.410086 systemd-logind[1722]: New session 3 of user core. Sep 13 00:03:37.411064 systemd[1]: Started session-3.scope. Sep 13 00:03:37.532939 sshd[1943]: pam_unix(sshd:session): session closed for user core Sep 13 00:03:37.537367 systemd[1]: session-3.scope: Deactivated successfully. Sep 13 00:03:37.538536 systemd[1]: sshd@2-172.31.27.4:22-139.178.89.65:43906.service: Deactivated successfully. Sep 13 00:03:37.540041 systemd-logind[1722]: Session 3 logged out. Waiting for processes to exit. Sep 13 00:03:37.541907 systemd-logind[1722]: Removed session 3. Sep 13 00:03:37.560674 systemd[1]: Started sshd@3-172.31.27.4:22-139.178.89.65:43914.service. Sep 13 00:03:37.736205 sshd[1949]: Accepted publickey for core from 139.178.89.65 port 43914 ssh2: RSA SHA256:hZ9iVout2PrR+GbvdOVRihMPHc0rDrYOM1fRKHgWdwM Sep 13 00:03:37.738871 sshd[1949]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 13 00:03:37.748065 systemd[1]: Started session-4.scope. Sep 13 00:03:37.750465 systemd-logind[1722]: New session 4 of user core. Sep 13 00:03:37.879845 sshd[1949]: pam_unix(sshd:session): session closed for user core Sep 13 00:03:37.885171 systemd-logind[1722]: Session 4 logged out. Waiting for processes to exit. Sep 13 00:03:37.887448 systemd[1]: sshd@3-172.31.27.4:22-139.178.89.65:43914.service: Deactivated successfully. Sep 13 00:03:37.888732 systemd[1]: session-4.scope: Deactivated successfully. Sep 13 00:03:37.889712 systemd-logind[1722]: Removed session 4. Sep 13 00:03:37.908291 systemd[1]: Started sshd@4-172.31.27.4:22-139.178.89.65:43926.service. Sep 13 00:03:38.081479 sshd[1955]: Accepted publickey for core from 139.178.89.65 port 43926 ssh2: RSA SHA256:hZ9iVout2PrR+GbvdOVRihMPHc0rDrYOM1fRKHgWdwM Sep 13 00:03:38.083839 sshd[1955]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 13 00:03:38.092495 systemd-logind[1722]: New session 5 of user core. Sep 13 00:03:38.092622 systemd[1]: Started session-5.scope. Sep 13 00:03:38.268061 sudo[1958]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 13 00:03:38.269149 sudo[1958]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 13 00:03:38.301718 dbus-daemon[1713]: avc: received setenforce notice (enforcing=1) Sep 13 00:03:38.304551 sudo[1958]: pam_unix(sudo:session): session closed for user root Sep 13 00:03:38.329477 sshd[1955]: pam_unix(sshd:session): session closed for user core Sep 13 00:03:38.335312 systemd-logind[1722]: Session 5 logged out. Waiting for processes to exit. Sep 13 00:03:38.335855 systemd[1]: sshd@4-172.31.27.4:22-139.178.89.65:43926.service: Deactivated successfully. Sep 13 00:03:38.337136 systemd[1]: session-5.scope: Deactivated successfully. Sep 13 00:03:38.338978 systemd-logind[1722]: Removed session 5. Sep 13 00:03:38.357176 systemd[1]: Started sshd@5-172.31.27.4:22-139.178.89.65:43938.service. Sep 13 00:03:38.527076 sshd[1962]: Accepted publickey for core from 139.178.89.65 port 43938 ssh2: RSA SHA256:hZ9iVout2PrR+GbvdOVRihMPHc0rDrYOM1fRKHgWdwM Sep 13 00:03:38.530066 sshd[1962]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 13 00:03:38.538434 systemd[1]: Started session-6.scope. Sep 13 00:03:38.539459 systemd-logind[1722]: New session 6 of user core. Sep 13 00:03:38.643590 sudo[1966]: 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 Sep 13 00:03:38.644109 sudo[1966]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 13 00:03:38.649476 sudo[1966]: pam_unix(sudo:session): session closed for user root Sep 13 00:03:38.658303 sudo[1965]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Sep 13 00:03:38.659297 sudo[1965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 13 00:03:38.677140 systemd[1]: Stopping audit-rules.service... Sep 13 00:03:38.677000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 13 00:03:38.681138 kernel: kauditd_printk_skb: 78 callbacks suppressed Sep 13 00:03:38.681236 kernel: audit: type=1305 audit(1757721818.677:172): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 13 00:03:38.677000 audit[1969]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffc0f617c0 a2=420 a3=0 items=0 ppid=1 pid=1969 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) Sep 13 00:03:38.686624 auditctl[1969]: No rules Sep 13 00:03:38.697360 kernel: audit: type=1300 audit(1757721818.677:172): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffc0f617c0 a2=420 a3=0 items=0 ppid=1 pid=1969 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) Sep 13 00:03:38.697998 systemd[1]: audit-rules.service: Deactivated successfully. Sep 13 00:03:38.677000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Sep 13 00:03:38.701667 kernel: audit: type=1327 audit(1757721818.677:172): proctitle=2F7362696E2F617564697463746C002D44 Sep 13 00:03:38.698429 systemd[1]: Stopped audit-rules.service. Sep 13 00:03:38.697000 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' Sep 13 00:03:38.708024 systemd[1]: Starting audit-rules.service... Sep 13 00:03:38.711460 kernel: audit: type=1131 audit(1757721818.697:173): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:38.735635 augenrules[1986]: No rules Sep 13 00:03:38.737210 systemd[1]: Finished audit-rules.service. Sep 13 00:03:38.736000 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' Sep 13 00:03:38.740105 sudo[1965]: pam_unix(sudo:session): session closed for user root Sep 13 00:03:38.738000 audit[1965]: USER_END pid=1965 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' Sep 13 00:03:38.755589 kernel: audit: type=1130 audit(1757721818.736:174): 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' Sep 13 00:03:38.755681 kernel: audit: type=1106 audit(1757721818.738:175): pid=1965 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' Sep 13 00:03:38.755726 kernel: audit: type=1104 audit(1757721818.738:176): pid=1965 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' Sep 13 00:03:38.738000 audit[1965]: CRED_DISP pid=1965 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' Sep 13 00:03:38.768723 sshd[1962]: pam_unix(sshd:session): session closed for user core Sep 13 00:03:38.769000 audit[1962]: USER_END pid=1962 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' Sep 13 00:03:38.774169 systemd[1]: sshd@5-172.31.27.4:22-139.178.89.65:43938.service: Deactivated successfully. Sep 13 00:03:38.775305 systemd[1]: session-6.scope: Deactivated successfully. Sep 13 00:03:38.776724 systemd-logind[1722]: Session 6 logged out. Waiting for processes to exit. Sep 13 00:03:38.778322 systemd-logind[1722]: Removed session 6. Sep 13 00:03:38.769000 audit[1962]: CRED_DISP pid=1962 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' Sep 13 00:03:38.792187 kernel: audit: type=1106 audit(1757721818.769:177): pid=1962 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' Sep 13 00:03:38.792256 kernel: audit: type=1104 audit(1757721818.769:178): pid=1962 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' Sep 13 00:03:38.773000 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.27.4:22-139.178.89.65:43938 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:38.801386 kernel: audit: type=1131 audit(1757721818.773:179): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-172.31.27.4:22-139.178.89.65:43938 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:38.801093 systemd[1]: Started sshd@6-172.31.27.4:22-139.178.89.65:43940.service. Sep 13 00:03:38.799000 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.27.4:22-139.178.89.65:43940 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:38.974000 audit[1992]: USER_ACCT pid=1992 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' Sep 13 00:03:38.976574 sshd[1992]: Accepted publickey for core from 139.178.89.65 port 43940 ssh2: RSA SHA256:hZ9iVout2PrR+GbvdOVRihMPHc0rDrYOM1fRKHgWdwM Sep 13 00:03:38.976000 audit[1992]: CRED_ACQ pid=1992 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' Sep 13 00:03:38.977000 audit[1992]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffc8d5a690 a2=3 a3=1 items=0 ppid=1 pid=1992 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) Sep 13 00:03:38.977000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Sep 13 00:03:38.978042 sshd[1992]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 13 00:03:38.986524 systemd[1]: Started session-7.scope. Sep 13 00:03:38.987236 systemd-logind[1722]: New session 7 of user core. Sep 13 00:03:38.995000 audit[1992]: USER_START pid=1992 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' Sep 13 00:03:38.998000 audit[1994]: CRED_ACQ pid=1994 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' Sep 13 00:03:39.108439 sshd[1992]: pam_unix(sshd:session): session closed for user core Sep 13 00:03:39.108000 audit[1992]: USER_END pid=1992 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' Sep 13 00:03:39.109000 audit[1992]: CRED_DISP pid=1992 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' Sep 13 00:03:39.113345 systemd[1]: sshd@6-172.31.27.4:22-139.178.89.65:43940.service: Deactivated successfully. Sep 13 00:03:39.112000 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.27.4:22-139.178.89.65:43940 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 13 00:03:39.114706 systemd[1]: session-7.scope: Deactivated successfully. Sep 13 00:03:39.115934 systemd-logind[1722]: Session 7 logged out. Waiting for processes to exit. Sep 13 00:03:39.117910 systemd-logind[1722]: Removed session 7.