Feb 9 09:44:36.963170 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083]
Feb 9 09:44:36.963208 kernel: Linux version 5.15.148-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 Feb 9 08:56:26 -00 2024
Feb 9 09:44:36.963230 kernel: efi: EFI v2.70 by EDK II
Feb 9 09:44:36.963245 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7ac1aa98 MEMRESERVE=0x71a8cf98
Feb 9 09:44:36.963259 kernel: ACPI: Early table checksum verification disabled
Feb 9 09:44:36.963273 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON)
Feb 9 09:44:36.963289 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013)
Feb 9 09:44:36.963303 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001)
Feb 9 09:44:36.963316 kernel: ACPI: DSDT 0x0000000078640000 00154F (v02 AMAZON AMZNDSDT 00000001 INTL 20160527)
Feb 9 09:44:36.963330 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001)
Feb 9 09:44:36.963366 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001)
Feb 9 09:44:36.963384 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001)
Feb 9 09:44:36.963399 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001)
Feb 9 09:44:36.963413 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001)
Feb 9 09:44:36.963430 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001)
Feb 9 09:44:36.963450 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001)
Feb 9 09:44:36.963464 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200
Feb 9 09:44:36.963479 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200')
Feb 9 09:44:36.963493 kernel: printk: bootconsole [uart0] enabled
Feb 9 09:44:36.963507 kernel: NUMA: Failed to initialise from firmware
Feb 9 09:44:36.963522 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff]
Feb 9 09:44:36.963536 kernel: NUMA: NODE_DATA [mem 0x4b5841900-0x4b5846fff]
Feb 9 09:44:36.963551 kernel: Zone ranges:
Feb 9 09:44:36.963565 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff]
Feb 9 09:44:36.963579 kernel: DMA32 empty
Feb 9 09:44:36.963593 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff]
Feb 9 09:44:36.963611 kernel: Movable zone start for each node
Feb 9 09:44:36.963626 kernel: Early memory node ranges
Feb 9 09:44:36.963640 kernel: node 0: [mem 0x0000000040000000-0x00000000786effff]
Feb 9 09:44:36.963655 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff]
Feb 9 09:44:36.963750 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff]
Feb 9 09:44:36.963767 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff]
Feb 9 09:44:36.963782 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff]
Feb 9 09:44:36.963796 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff]
Feb 9 09:44:36.963811 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff]
Feb 9 09:44:36.963825 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges
Feb 9 09:44:36.963839 kernel: psci: probing for conduit method from ACPI.
Feb 9 09:44:36.963854 kernel: psci: PSCIv1.0 detected in firmware.
Feb 9 09:44:36.963874 kernel: psci: Using standard PSCI v0.2 function IDs
Feb 9 09:44:36.963889 kernel: psci: Trusted OS migration not required
Feb 9 09:44:36.963910 kernel: psci: SMC Calling Convention v1.1
Feb 9 09:44:36.963925 kernel: ACPI: SRAT not present
Feb 9 09:44:36.963940 kernel: percpu: Embedded 29 pages/cpu s79960 r8192 d30632 u118784
Feb 9 09:44:36.963960 kernel: pcpu-alloc: s79960 r8192 d30632 u118784 alloc=29*4096
Feb 9 09:44:36.963975 kernel: pcpu-alloc: [0] 0 [0] 1
Feb 9 09:44:36.963990 kernel: Detected PIPT I-cache on CPU0
Feb 9 09:44:36.964005 kernel: CPU features: detected: GIC system register CPU interface
Feb 9 09:44:36.964020 kernel: CPU features: detected: Spectre-v2
Feb 9 09:44:36.964034 kernel: CPU features: detected: Spectre-v3a
Feb 9 09:44:36.964049 kernel: CPU features: detected: Spectre-BHB
Feb 9 09:44:36.964064 kernel: CPU features: kernel page table isolation forced ON by KASLR
Feb 9 09:44:36.964079 kernel: CPU features: detected: Kernel page table isolation (KPTI)
Feb 9 09:44:36.964094 kernel: CPU features: detected: ARM erratum 1742098
Feb 9 09:44:36.964109 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923
Feb 9 09:44:36.964128 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872
Feb 9 09:44:36.964143 kernel: Policy zone: Normal
Feb 9 09:44:36.964161 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=14ffd9340f674a8d04c9d43eed85484d8b2b7e2bcd8b36a975c9ac66063d537d
Feb 9 09:44:36.964176 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
Feb 9 09:44:36.964191 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
Feb 9 09:44:36.964207 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
Feb 9 09:44:36.964222 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Feb 9 09:44:36.964237 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB)
Feb 9 09:44:36.964253 kernel: Memory: 3826316K/4030464K available (9792K kernel code, 2092K rwdata, 7556K rodata, 34688K init, 778K bss, 204148K reserved, 0K cma-reserved)
Feb 9 09:44:36.964268 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
Feb 9 09:44:36.964287 kernel: trace event string verifier disabled
Feb 9 09:44:36.964302 kernel: rcu: Preemptible hierarchical RCU implementation.
Feb 9 09:44:36.964318 kernel: rcu: RCU event tracing is enabled.
Feb 9 09:44:36.964333 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
Feb 9 09:44:36.984958 kernel: Trampoline variant of Tasks RCU enabled.
Feb 9 09:44:36.984988 kernel: Tracing variant of Tasks RCU enabled.
Feb 9 09:44:36.985004 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
Feb 9 09:44:36.985020 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
Feb 9 09:44:36.985036 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
Feb 9 09:44:36.985051 kernel: GICv3: 96 SPIs implemented
Feb 9 09:44:36.985066 kernel: GICv3: 0 Extended SPIs implemented
Feb 9 09:44:36.985081 kernel: GICv3: Distributor has no Range Selector support
Feb 9 09:44:36.985106 kernel: Root IRQ handler: gic_handle_irq
Feb 9 09:44:36.985121 kernel: GICv3: 16 PPIs implemented
Feb 9 09:44:36.985136 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000
Feb 9 09:44:36.985151 kernel: ACPI: SRAT not present
Feb 9 09:44:36.985165 kernel: ITS [mem 0x10080000-0x1009ffff]
Feb 9 09:44:36.985181 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000a0000 (indirect, esz 8, psz 64K, shr 1)
Feb 9 09:44:36.985196 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000b0000 (flat, esz 8, psz 64K, shr 1)
Feb 9 09:44:36.985211 kernel: GICv3: using LPI property table @0x00000004000c0000
Feb 9 09:44:36.985226 kernel: ITS: Using hypervisor restricted LPI range [128]
Feb 9 09:44:36.985241 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000d0000
Feb 9 09:44:36.985256 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt).
Feb 9 09:44:36.985276 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns
Feb 9 09:44:36.985292 kernel: sched_clock: 56 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns
Feb 9 09:44:36.985307 kernel: Console: colour dummy device 80x25
Feb 9 09:44:36.985323 kernel: printk: console [tty1] enabled
Feb 9 09:44:36.985338 kernel: ACPI: Core revision 20210730
Feb 9 09:44:36.985377 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333)
Feb 9 09:44:36.985394 kernel: pid_max: default: 32768 minimum: 301
Feb 9 09:44:36.985410 kernel: LSM: Security Framework initializing
Feb 9 09:44:36.985441 kernel: SELinux: Initializing.
Feb 9 09:44:36.985459 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Feb 9 09:44:36.985481 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Feb 9 09:44:36.985496 kernel: rcu: Hierarchical SRCU implementation.
Feb 9 09:44:36.985512 kernel: Platform MSI: ITS@0x10080000 domain created
Feb 9 09:44:36.985527 kernel: PCI/MSI: ITS@0x10080000 domain created
Feb 9 09:44:36.985542 kernel: Remapping and enabling EFI services.
Feb 9 09:44:36.985558 kernel: smp: Bringing up secondary CPUs ...
Feb 9 09:44:36.985573 kernel: Detected PIPT I-cache on CPU1
Feb 9 09:44:36.985589 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000
Feb 9 09:44:36.985604 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000e0000
Feb 9 09:44:36.985624 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083]
Feb 9 09:44:36.985639 kernel: smp: Brought up 1 node, 2 CPUs
Feb 9 09:44:36.985654 kernel: SMP: Total of 2 processors activated.
Feb 9 09:44:36.985670 kernel: CPU features: detected: 32-bit EL0 Support
Feb 9 09:44:36.985685 kernel: CPU features: detected: 32-bit EL1 Support
Feb 9 09:44:36.985700 kernel: CPU features: detected: CRC32 instructions
Feb 9 09:44:36.985716 kernel: CPU: All CPU(s) started at EL1
Feb 9 09:44:36.985731 kernel: alternatives: patching kernel code
Feb 9 09:44:36.985746 kernel: devtmpfs: initialized
Feb 9 09:44:36.985766 kernel: KASLR disabled due to lack of seed
Feb 9 09:44:36.985781 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
Feb 9 09:44:36.985797 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear)
Feb 9 09:44:36.985823 kernel: pinctrl core: initialized pinctrl subsystem
Feb 9 09:44:36.985843 kernel: SMBIOS 3.0.0 present.
Feb 9 09:44:36.985860 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018
Feb 9 09:44:36.985875 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Feb 9 09:44:36.985892 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
Feb 9 09:44:36.985908 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
Feb 9 09:44:36.985925 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
Feb 9 09:44:36.985941 kernel: audit: initializing netlink subsys (disabled)
Feb 9 09:44:36.985958 kernel: audit: type=2000 audit(0.248:1): state=initialized audit_enabled=0 res=1
Feb 9 09:44:36.985979 kernel: thermal_sys: Registered thermal governor 'step_wise'
Feb 9 09:44:36.985995 kernel: cpuidle: using governor menu
Feb 9 09:44:36.986011 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
Feb 9 09:44:36.986028 kernel: ASID allocator initialised with 32768 entries
Feb 9 09:44:36.986044 kernel: ACPI: bus type PCI registered
Feb 9 09:44:36.986064 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Feb 9 09:44:36.986080 kernel: Serial: AMBA PL011 UART driver
Feb 9 09:44:36.986097 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
Feb 9 09:44:36.986113 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
Feb 9 09:44:36.986129 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
Feb 9 09:44:36.986145 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
Feb 9 09:44:36.986161 kernel: cryptd: max_cpu_qlen set to 1000
Feb 9 09:44:36.986178 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng)
Feb 9 09:44:36.986194 kernel: ACPI: Added _OSI(Module Device)
Feb 9 09:44:36.986215 kernel: ACPI: Added _OSI(Processor Device)
Feb 9 09:44:36.986231 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Feb 9 09:44:36.986247 kernel: ACPI: Added _OSI(Processor Aggregator Device)
Feb 9 09:44:36.986263 kernel: ACPI: Added _OSI(Linux-Dell-Video)
Feb 9 09:44:36.986279 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
Feb 9 09:44:36.986295 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
Feb 9 09:44:36.986312 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
Feb 9 09:44:36.986328 kernel: ACPI: Interpreter enabled
Feb 9 09:44:36.986361 kernel: ACPI: Using GIC for interrupt routing
Feb 9 09:44:36.992454 kernel: ACPI: MCFG table detected, 1 entries
Feb 9 09:44:36.992475 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f])
Feb 9 09:44:36.992774 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
Feb 9 09:44:36.992979 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR]
Feb 9 09:44:36.993180 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]
Feb 9 09:44:36.993408 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00
Feb 9 09:44:36.993634 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f]
Feb 9 09:44:36.993664 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window]
Feb 9 09:44:36.993681 kernel: acpiphp: Slot [1] registered
Feb 9 09:44:36.993698 kernel: acpiphp: Slot [2] registered
Feb 9 09:44:36.993715 kernel: acpiphp: Slot [3] registered
Feb 9 09:44:36.993731 kernel: acpiphp: Slot [4] registered
Feb 9 09:44:36.993747 kernel: acpiphp: Slot [5] registered
Feb 9 09:44:36.993763 kernel: acpiphp: Slot [6] registered
Feb 9 09:44:36.993779 kernel: acpiphp: Slot [7] registered
Feb 9 09:44:36.993795 kernel: acpiphp: Slot [8] registered
Feb 9 09:44:36.993815 kernel: acpiphp: Slot [9] registered
Feb 9 09:44:36.993831 kernel: acpiphp: Slot [10] registered
Feb 9 09:44:36.993847 kernel: acpiphp: Slot [11] registered
Feb 9 09:44:36.993863 kernel: acpiphp: Slot [12] registered
Feb 9 09:44:36.993879 kernel: acpiphp: Slot [13] registered
Feb 9 09:44:36.993895 kernel: acpiphp: Slot [14] registered
Feb 9 09:44:36.993911 kernel: acpiphp: Slot [15] registered
Feb 9 09:44:36.993927 kernel: acpiphp: Slot [16] registered
Feb 9 09:44:36.993943 kernel: acpiphp: Slot [17] registered
Feb 9 09:44:36.993959 kernel: acpiphp: Slot [18] registered
Feb 9 09:44:36.993979 kernel: acpiphp: Slot [19] registered
Feb 9 09:44:36.993995 kernel: acpiphp: Slot [20] registered
Feb 9 09:44:36.994010 kernel: acpiphp: Slot [21] registered
Feb 9 09:44:36.994026 kernel: acpiphp: Slot [22] registered
Feb 9 09:44:36.994042 kernel: acpiphp: Slot [23] registered
Feb 9 09:44:36.994058 kernel: acpiphp: Slot [24] registered
Feb 9 09:44:36.994074 kernel: acpiphp: Slot [25] registered
Feb 9 09:44:36.994090 kernel: acpiphp: Slot [26] registered
Feb 9 09:44:36.994106 kernel: acpiphp: Slot [27] registered
Feb 9 09:44:36.994126 kernel: acpiphp: Slot [28] registered
Feb 9 09:44:36.994142 kernel: acpiphp: Slot [29] registered
Feb 9 09:44:36.994158 kernel: acpiphp: Slot [30] registered
Feb 9 09:44:36.994174 kernel: acpiphp: Slot [31] registered
Feb 9 09:44:36.994190 kernel: PCI host bridge to bus 0000:00
Feb 9 09:44:36.994431 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window]
Feb 9 09:44:36.996084 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]
Feb 9 09:44:36.996282 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window]
Feb 9 09:44:36.999611 kernel: pci_bus 0000:00: root bus resource [bus 00-0f]
Feb 9 09:44:36.999849 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000
Feb 9 09:44:37.000065 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003
Feb 9 09:44:37.003527 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff]
Feb 9 09:44:37.003751 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802
Feb 9 09:44:37.003951 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff]
Feb 9 09:44:37.004156 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold
Feb 9 09:44:37.005477 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000
Feb 9 09:44:37.005728 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff]
Feb 9 09:44:37.005933 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref]
Feb 9 09:44:37.006135 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff]
Feb 9 09:44:37.006335 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold
Feb 9 09:44:37.006578 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref]
Feb 9 09:44:37.006788 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff]
Feb 9 09:44:37.006992 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff]
Feb 9 09:44:37.007191 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff]
Feb 9 09:44:37.012694 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff]
Feb 9 09:44:37.012916 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window]
Feb 9 09:44:37.013097 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]
Feb 9 09:44:37.013276 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window]
Feb 9 09:44:37.013308 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35
Feb 9 09:44:37.013326 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36
Feb 9 09:44:37.013363 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37
Feb 9 09:44:37.013385 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38
Feb 9 09:44:37.013403 kernel: iommu: Default domain type: Translated
Feb 9 09:44:37.013420 kernel: iommu: DMA domain TLB invalidation policy: strict mode
Feb 9 09:44:37.013454 kernel: vgaarb: loaded
Feb 9 09:44:37.013471 kernel: pps_core: LinuxPPS API ver. 1 registered
Feb 9 09:44:37.013488 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Feb 9 09:44:37.013509 kernel: PTP clock support registered
Feb 9 09:44:37.013526 kernel: Registered efivars operations
Feb 9 09:44:37.013542 kernel: clocksource: Switched to clocksource arch_sys_counter
Feb 9 09:44:37.013558 kernel: VFS: Disk quotas dquot_6.6.0
Feb 9 09:44:37.013574 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Feb 9 09:44:37.013590 kernel: pnp: PnP ACPI init
Feb 9 09:44:37.013814 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved
Feb 9 09:44:37.013839 kernel: pnp: PnP ACPI: found 1 devices
Feb 9 09:44:37.013856 kernel: NET: Registered PF_INET protocol family
Feb 9 09:44:37.013877 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
Feb 9 09:44:37.013894 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
Feb 9 09:44:37.013911 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Feb 9 09:44:37.013927 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
Feb 9 09:44:37.013944 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
Feb 9 09:44:37.013960 kernel: TCP: Hash tables configured (established 32768 bind 32768)
Feb 9 09:44:37.013976 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
Feb 9 09:44:37.013992 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
Feb 9 09:44:37.014009 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Feb 9 09:44:37.014029 kernel: PCI: CLS 0 bytes, default 64
Feb 9 09:44:37.014045 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available
Feb 9 09:44:37.014062 kernel: kvm [1]: HYP mode not available
Feb 9 09:44:37.014078 kernel: Initialise system trusted keyrings
Feb 9 09:44:37.014094 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
Feb 9 09:44:37.014111 kernel: Key type asymmetric registered
Feb 9 09:44:37.014127 kernel: Asymmetric key parser 'x509' registered
Feb 9 09:44:37.014143 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Feb 9 09:44:37.014159 kernel: io scheduler mq-deadline registered
Feb 9 09:44:37.014179 kernel: io scheduler kyber registered
Feb 9 09:44:37.014195 kernel: io scheduler bfq registered
Feb 9 09:44:37.014415 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered
Feb 9 09:44:37.014441 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
Feb 9 09:44:37.014458 kernel: ACPI: button: Power Button [PWRB]
Feb 9 09:44:37.014475 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Feb 9 09:44:37.014492 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37
Feb 9 09:44:37.014692 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012)
Feb 9 09:44:37.014720 kernel: printk: console [ttyS0] disabled
Feb 9 09:44:37.014737 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A
Feb 9 09:44:37.014754 kernel: printk: console [ttyS0] enabled
Feb 9 09:44:37.014770 kernel: printk: bootconsole [uart0] disabled
Feb 9 09:44:37.014786 kernel: thunder_xcv, ver 1.0
Feb 9 09:44:37.014802 kernel: thunder_bgx, ver 1.0
Feb 9 09:44:37.014818 kernel: nicpf, ver 1.0
Feb 9 09:44:37.014834 kernel: nicvf, ver 1.0
Feb 9 09:44:37.015037 kernel: rtc-efi rtc-efi.0: registered as rtc0
Feb 9 09:44:37.015229 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-02-09T09:44:36 UTC (1707471876)
Feb 9 09:44:37.015252 kernel: hid: raw HID events driver (C) Jiri Kosina
Feb 9 09:44:37.015268 kernel: NET: Registered PF_INET6 protocol family
Feb 9 09:44:37.015284 kernel: Segment Routing with IPv6
Feb 9 09:44:37.015300 kernel: In-situ OAM (IOAM) with IPv6
Feb 9 09:44:37.015317 kernel: NET: Registered PF_PACKET protocol family
Feb 9 09:44:37.015333 kernel: Key type dns_resolver registered
Feb 9 09:44:37.015366 kernel: registered taskstats version 1
Feb 9 09:44:37.015390 kernel: Loading compiled-in X.509 certificates
Feb 9 09:44:37.015407 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.148-flatcar: ca91574208414224935c9cea513398977daf917d'
Feb 9 09:44:37.015423 kernel: Key type .fscrypt registered
Feb 9 09:44:37.015439 kernel: Key type fscrypt-provisioning registered
Feb 9 09:44:37.015454 kernel: ima: No TPM chip found, activating TPM-bypass!
Feb 9 09:44:37.015471 kernel: ima: Allocated hash algorithm: sha1
Feb 9 09:44:37.015487 kernel: ima: No architecture policies found
Feb 9 09:44:37.015503 kernel: Freeing unused kernel memory: 34688K
Feb 9 09:44:37.015519 kernel: Run /init as init process
Feb 9 09:44:37.015538 kernel: with arguments:
Feb 9 09:44:37.015555 kernel: /init
Feb 9 09:44:37.015571 kernel: with environment:
Feb 9 09:44:37.015586 kernel: HOME=/
Feb 9 09:44:37.015602 kernel: TERM=linux
Feb 9 09:44:37.015618 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a
Feb 9 09:44:37.015639 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)
Feb 9 09:44:37.015659 systemd[1]: Detected virtualization amazon.
Feb 9 09:44:37.015681 systemd[1]: Detected architecture arm64.
Feb 9 09:44:37.015699 systemd[1]: Running in initrd.
Feb 9 09:44:37.015716 systemd[1]: No hostname configured, using default hostname.
Feb 9 09:44:37.015733 systemd[1]: Hostname set to <localhost>.
Feb 9 09:44:37.015751 systemd[1]: Initializing machine ID from VM UUID.
Feb 9 09:44:37.015769 systemd[1]: Queued start job for default target initrd.target.
Feb 9 09:44:37.015786 systemd[1]: Started systemd-ask-password-console.path.
Feb 9 09:44:37.015803 systemd[1]: Reached target cryptsetup.target.
Feb 9 09:44:37.015823 systemd[1]: Reached target paths.target.
Feb 9 09:44:37.015841 systemd[1]: Reached target slices.target.
Feb 9 09:44:37.015858 systemd[1]: Reached target swap.target.
Feb 9 09:44:37.015875 systemd[1]: Reached target timers.target.
Feb 9 09:44:37.015894 systemd[1]: Listening on iscsid.socket.
Feb 9 09:44:37.015911 systemd[1]: Listening on iscsiuio.socket.
Feb 9 09:44:37.015928 systemd[1]: Listening on systemd-journald-audit.socket.
Feb 9 09:44:37.015946 systemd[1]: Listening on systemd-journald-dev-log.socket.
Feb 9 09:44:37.015967 systemd[1]: Listening on systemd-journald.socket.
Feb 9 09:44:37.015984 systemd[1]: Listening on systemd-networkd.socket.
Feb 9 09:44:37.016002 systemd[1]: Listening on systemd-udevd-control.socket.
Feb 9 09:44:37.016019 systemd[1]: Listening on systemd-udevd-kernel.socket.
Feb 9 09:44:37.016036 systemd[1]: Reached target sockets.target.
Feb 9 09:44:37.016054 systemd[1]: Starting kmod-static-nodes.service...
Feb 9 09:44:37.016071 systemd[1]: Finished network-cleanup.service.
Feb 9 09:44:37.016089 systemd[1]: Starting systemd-fsck-usr.service...
Feb 9 09:44:37.016106 systemd[1]: Starting systemd-journald.service...
Feb 9 09:44:37.016127 systemd[1]: Starting systemd-modules-load.service...
Feb 9 09:44:37.016145 systemd[1]: Starting systemd-resolved.service...
Feb 9 09:44:37.016162 systemd[1]: Starting systemd-vconsole-setup.service...
Feb 9 09:44:37.016180 systemd[1]: Finished kmod-static-nodes.service.
Feb 9 09:44:37.016197 systemd[1]: Finished systemd-fsck-usr.service.
Feb 9 09:44:37.016215 kernel: audit: type=1130 audit(1707471876.951:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:37.016232 systemd[1]: Starting systemd-tmpfiles-setup-dev.service...
Feb 9 09:44:37.016250 systemd[1]: Finished systemd-vconsole-setup.service.
Feb 9 09:44:37.016271 kernel: audit: type=1130 audit(1707471876.974:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:37.016289 systemd[1]: Starting dracut-cmdline-ask.service...
Feb 9 09:44:37.016306 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Feb 9 09:44:37.016322 kernel: Bridge firewalling registered
Feb 9 09:44:37.016339 systemd[1]: Finished systemd-tmpfiles-setup-dev.service.
Feb 9 09:44:37.016375 kernel: audit: type=1130 audit(1707471877.011:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:37.016396 systemd-journald[309]: Journal started
Feb 9 09:44:37.016484 systemd-journald[309]: Runtime Journal (/run/log/journal/ec2d7c527f3f1e3ada513676197c00ed) is 8.0M, max 75.4M, 67.4M free.
Feb 9 09:44:37.029200 systemd[1]: Started systemd-journald.service.
Feb 9 09:44:36.951000 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'
Feb 9 09:44:36.974000 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'
Feb 9 09:44:37.011000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:36.941937 systemd-modules-load[310]: Inserted module 'overlay'
Feb 9 09:44:36.997487 systemd-modules-load[310]: Inserted module 'br_netfilter'
Feb 9 09:44:37.036948 kernel: SCSI subsystem initialized
Feb 9 09:44:37.035000 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'
Feb 9 09:44:37.045839 kernel: audit: type=1130 audit(1707471877.035: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'
Feb 9 09:44:37.065803 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
Feb 9 09:44:37.065872 kernel: device-mapper: uevent: version 1.0.3
Feb 9 09:44:37.069005 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com
Feb 9 09:44:37.072713 systemd[1]: Finished dracut-cmdline-ask.service.
Feb 9 09:44:37.088550 kernel: audit: type=1130 audit(1707471877.074:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:37.074000 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'
Feb 9 09:44:37.077268 systemd[1]: Starting dracut-cmdline.service...
Feb 9 09:44:37.086448 systemd-modules-load[310]: Inserted module 'dm_multipath'
Feb 9 09:44:37.090842 systemd[1]: Finished systemd-modules-load.service.
Feb 9 09:44:37.091642 systemd-resolved[311]: Positive Trust Anchors:
Feb 9 09:44:37.091656 systemd-resolved[311]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Feb 9 09:44:37.091708 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
Feb 9 09:44:37.138000 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'
Feb 9 09:44:37.140899 systemd[1]: Starting systemd-sysctl.service...
Feb 9 09:44:37.151314 kernel: audit: type=1130 audit(1707471877.138:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:37.160494 dracut-cmdline[327]: dracut-dracut-053
Feb 9 09:44:37.167029 dracut-cmdline[327]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=14ffd9340f674a8d04c9d43eed85484d8b2b7e2bcd8b36a975c9ac66063d537d
Feb 9 09:44:37.183052 systemd[1]: Finished systemd-sysctl.service.
Feb 9 09:44:37.193444 kernel: audit: type=1130 audit(1707471877.183:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:37.183000 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'
Feb 9 09:44:37.295371 kernel: Loading iSCSI transport class v2.0-870.
Feb 9 09:44:37.306379 kernel: iscsi: registered transport (tcp)
Feb 9 09:44:37.330458 kernel: iscsi: registered transport (qla4xxx)
Feb 9 09:44:37.330528 kernel: QLogic iSCSI HBA Driver
Feb 9 09:44:37.484880 systemd-resolved[311]: Defaulting to hostname 'linux'.
Feb 9 09:44:37.487626 kernel: random: crng init done
Feb 9 09:44:37.487633 systemd[1]: Started systemd-resolved.service.
Feb 9 09:44:37.488000 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'
Feb 9 09:44:37.499454 kernel: audit: type=1130 audit(1707471877.488:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:37.490468 systemd[1]: Reached target nss-lookup.target.
Feb 9 09:44:37.517120 systemd[1]: Finished dracut-cmdline.service.
Feb 9 09:44:37.518000 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'
Feb 9 09:44:37.521742 systemd[1]: Starting dracut-pre-udev.service...
Feb 9 09:44:37.530380 kernel: audit: type=1130 audit(1707471877.518:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:37.587388 kernel: raid6: neonx8 gen() 6379 MB/s
Feb 9 09:44:37.605377 kernel: raid6: neonx8 xor() 4761 MB/s
Feb 9 09:44:37.623376 kernel: raid6: neonx4 gen() 6464 MB/s
Feb 9 09:44:37.641376 kernel: raid6: neonx4 xor() 4948 MB/s
Feb 9 09:44:37.659375 kernel: raid6: neonx2 gen() 5745 MB/s
Feb 9 09:44:37.677375 kernel: raid6: neonx2 xor() 4543 MB/s
Feb 9 09:44:37.695376 kernel: raid6: neonx1 gen() 4453 MB/s
Feb 9 09:44:37.713376 kernel: raid6: neonx1 xor() 3687 MB/s
Feb 9 09:44:37.731375 kernel: raid6: int64x8 gen() 3411 MB/s
Feb 9 09:44:37.749375 kernel: raid6: int64x8 xor() 2099 MB/s
Feb 9 09:44:37.767375 kernel: raid6: int64x4 gen() 3773 MB/s
Feb 9 09:44:37.785375 kernel: raid6: int64x4 xor() 2201 MB/s
Feb 9 09:44:37.803376 kernel: raid6: int64x2 gen() 3574 MB/s
Feb 9 09:44:37.821376 kernel: raid6: int64x2 xor() 1954 MB/s
Feb 9 09:44:37.839376 kernel: raid6: int64x1 gen() 2771 MB/s
Feb 9 09:44:37.858864 kernel: raid6: int64x1 xor() 1453 MB/s
Feb 9 09:44:37.858898 kernel: raid6: using algorithm neonx4 gen() 6464 MB/s
Feb 9 09:44:37.858922 kernel: raid6: .... xor() 4948 MB/s, rmw enabled
Feb 9 09:44:37.860643 kernel: raid6: using neon recovery algorithm
Feb 9 09:44:37.879383 kernel: xor: measuring software checksum speed
Feb 9 09:44:37.883932 kernel: 8regs : 9334 MB/sec
Feb 9 09:44:37.883963 kernel: 32regs : 11106 MB/sec
Feb 9 09:44:37.888412 kernel: arm64_neon : 9597 MB/sec
Feb 9 09:44:37.888444 kernel: xor: using function: 32regs (11106 MB/sec)
Feb 9 09:44:37.979390 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no
Feb 9 09:44:37.996143 systemd[1]: Finished dracut-pre-udev.service.
Feb 9 09:44:37.997000 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'
Feb 9 09:44:37.997000 audit: BPF prog-id=7 op=LOAD
Feb 9 09:44:37.997000 audit: BPF prog-id=8 op=LOAD
Feb 9 09:44:38.002070 systemd[1]: Starting systemd-udevd.service...
Feb 9 09:44:38.031159 systemd-udevd[508]: Using default interface naming scheme 'v252'.
Feb 9 09:44:38.042392 systemd[1]: Started systemd-udevd.service.
Feb 9 09:44:38.044000 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'
Feb 9 09:44:38.050337 systemd[1]: Starting dracut-pre-trigger.service...
Feb 9 09:44:38.079792 dracut-pre-trigger[519]: rd.md=0: removing MD RAID activation
Feb 9 09:44:38.140585 systemd[1]: Finished dracut-pre-trigger.service.
Feb 9 09:44:38.141000 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'
Feb 9 09:44:38.147727 systemd[1]: Starting systemd-udev-trigger.service...
Feb 9 09:44:38.253376 systemd[1]: Finished systemd-udev-trigger.service.
Feb 9 09:44:38.254000 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'
Feb 9 09:44:38.387899 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36
Feb 9 09:44:38.387982 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012)
Feb 9 09:44:38.398302 kernel: ena 0000:00:05.0: ENA device version: 0.10
Feb 9 09:44:38.398609 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1
Feb 9 09:44:38.407856 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35
Feb 9 09:44:38.407922 kernel: nvme nvme0: pci function 0000:00:04.0
Feb 9 09:44:38.416387 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:c5:98:53:c6:a3
Feb 9 09:44:38.420388 kernel: nvme nvme0: 2/0/0 default/read/poll queues
Feb 9 09:44:38.426526 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk.
Feb 9 09:44:38.426570 kernel: GPT:9289727 != 16777215
Feb 9 09:44:38.426595 kernel: GPT:Alternate GPT header not at the end of the disk.
Feb 9 09:44:38.428672 kernel: GPT:9289727 != 16777215
Feb 9 09:44:38.429961 kernel: GPT: Use GNU Parted to correct GPT errors.
Feb 9 09:44:38.433305 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9
Feb 9 09:44:38.438100 (udev-worker)[565]: Network interface NamePolicy= disabled on kernel command line.
Feb 9 09:44:38.520606 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device.
Feb 9 09:44:38.536390 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by (udev-worker) (558)
Feb 9 09:44:38.599881 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device.
Feb 9 09:44:38.642822 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device.
Feb 9 09:44:38.655177 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device.
Feb 9 09:44:38.662511 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device.
Feb 9 09:44:38.668641 systemd[1]: Starting disk-uuid.service...
Feb 9 09:44:38.688624 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9
Feb 9 09:44:38.688815 disk-uuid[669]: Primary Header is updated.
Feb 9 09:44:38.688815 disk-uuid[669]: Secondary Entries is updated.
Feb 9 09:44:38.688815 disk-uuid[669]: Secondary Header is updated.
Feb 9 09:44:38.696385 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9
Feb 9 09:44:38.704390 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9
Feb 9 09:44:39.706784 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9
Feb 9 09:44:39.706859 disk-uuid[670]: The operation has completed successfully.
Feb 9 09:44:39.860814 systemd[1]: disk-uuid.service: Deactivated successfully.
Feb 9 09:44:39.863132 systemd[1]: Finished disk-uuid.service.
Feb 9 09:44:39.864000 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'
Feb 9 09:44:39.864000 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'
Feb 9 09:44:39.886086 systemd[1]: Starting verity-setup.service...
Feb 9 09:44:39.917394 kernel: device-mapper: verity: sha256 using implementation "sha256-ce"
Feb 9 09:44:39.996719 systemd[1]: Found device dev-mapper-usr.device.
Feb 9 09:44:40.002803 systemd[1]: Mounting sysusr-usr.mount...
Feb 9 09:44:40.008944 systemd[1]: Finished verity-setup.service.
Feb 9 09:44:40.009000 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'
Feb 9 09:44:40.091397 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none.
Feb 9 09:44:40.092186 systemd[1]: Mounted sysusr-usr.mount.
Feb 9 09:44:40.095436 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met.
Feb 9 09:44:40.099451 systemd[1]: Starting ignition-setup.service...
Feb 9 09:44:40.102277 systemd[1]: Starting parse-ip-for-networkd.service...
Feb 9 09:44:40.132721 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm
Feb 9 09:44:40.132788 kernel: BTRFS info (device nvme0n1p6): using free space tree
Feb 9 09:44:40.135418 kernel: BTRFS info (device nvme0n1p6): has skinny extents
Feb 9 09:44:40.147373 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations
Feb 9 09:44:40.165721 systemd[1]: mnt-oem.mount: Deactivated successfully.
Feb 9 09:44:40.197103 systemd[1]: Finished ignition-setup.service.
Feb 9 09:44:40.199000 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'
Feb 9 09:44:40.201757 systemd[1]: Starting ignition-fetch-offline.service...
Feb 9 09:44:40.258301 systemd[1]: Finished parse-ip-for-networkd.service.
Feb 9 09:44:40.260000 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'
Feb 9 09:44:40.261000 audit: BPF prog-id=9 op=LOAD
Feb 9 09:44:40.264037 systemd[1]: Starting systemd-networkd.service...
Feb 9 09:44:40.310832 systemd-networkd[1181]: lo: Link UP
Feb 9 09:44:40.310854 systemd-networkd[1181]: lo: Gained carrier
Feb 9 09:44:40.313547 systemd-networkd[1181]: Enumeration completed
Feb 9 09:44:40.317000 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'
Feb 9 09:44:40.315365 systemd-networkd[1181]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Feb 9 09:44:40.317115 systemd[1]: Started systemd-networkd.service.
Feb 9 09:44:40.319577 systemd[1]: Reached target network.target.
Feb 9 09:44:40.340225 systemd[1]: Starting iscsiuio.service...
Feb 9 09:44:40.349933 systemd-networkd[1181]: eth0: Link UP
Feb 9 09:44:40.358000 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'
Feb 9 09:44:40.349944 systemd-networkd[1181]: eth0: Gained carrier
Feb 9 09:44:40.358034 systemd[1]: Started iscsiuio.service.
Feb 9 09:44:40.372547 iscsid[1186]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi
Feb 9 09:44:40.372547 iscsid[1186]: 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
Feb 9 09:44:40.372547 iscsid[1186]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.<reversed domain name>[:identifier].
Feb 9 09:44:40.372547 iscsid[1186]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6.
Feb 9 09:44:40.372547 iscsid[1186]: If using hardware iscsi like qla4xxx this message can be ignored.
Feb 9 09:44:40.372547 iscsid[1186]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi
Feb 9 09:44:40.372547 iscsid[1186]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf
Feb 9 09:44:40.375682 systemd[1]: Starting iscsid.service...
Feb 9 09:44:40.396849 systemd[1]: Started iscsid.service.
Feb 9 09:44:40.398000 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'
Feb 9 09:44:40.414055 systemd[1]: Starting dracut-initqueue.service...
Feb 9 09:44:40.414953 systemd-networkd[1181]: eth0: DHCPv4 address 172.31.25.229/20, gateway 172.31.16.1 acquired from 172.31.16.1
Feb 9 09:44:40.441141 systemd[1]: Finished dracut-initqueue.service.
Feb 9 09:44:40.444556 systemd[1]: Reached target remote-fs-pre.target.
Feb 9 09:44:40.443000 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'
Feb 9 09:44:40.447903 systemd[1]: Reached target remote-cryptsetup.target.
Feb 9 09:44:40.451194 systemd[1]: Reached target remote-fs.target.
Feb 9 09:44:40.457115 systemd[1]: Starting dracut-pre-mount.service...
Feb 9 09:44:40.475116 systemd[1]: Finished dracut-pre-mount.service.
Feb 9 09:44:40.476000 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'
Feb 9 09:44:40.810331 ignition[1135]: Ignition 2.14.0
Feb 9 09:44:40.810384 ignition[1135]: Stage: fetch-offline
Feb 9 09:44:40.810695 ignition[1135]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Feb 9 09:44:40.810761 ignition[1135]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Feb 9 09:44:40.827543 ignition[1135]: no config dir at "/usr/lib/ignition/base.platform.d/aws"
Feb 9 09:44:40.828188 ignition[1135]: Ignition finished successfully
Feb 9 09:44:40.833255 systemd[1]: Finished ignition-fetch-offline.service.
Feb 9 09:44:40.852558 kernel: kauditd_printk_skb: 17 callbacks suppressed
Feb 9 09:44:40.852606 kernel: audit: type=1130 audit(1707471880.833:28): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:40.833000 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'
Feb 9 09:44:40.835993 systemd[1]: Starting ignition-fetch.service...
Feb 9 09:44:40.860729 ignition[1205]: Ignition 2.14.0
Feb 9 09:44:40.861212 ignition[1205]: Stage: fetch
Feb 9 09:44:40.861567 ignition[1205]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Feb 9 09:44:40.861626 ignition[1205]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Feb 9 09:44:40.876867 ignition[1205]: no config dir at "/usr/lib/ignition/base.platform.d/aws"
Feb 9 09:44:40.879299 ignition[1205]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Feb 9 09:44:40.887510 ignition[1205]: INFO : PUT result: OK
Feb 9 09:44:40.890830 ignition[1205]: DEBUG : parsed url from cmdline: ""
Feb 9 09:44:40.892673 ignition[1205]: INFO : no config URL provided
Feb 9 09:44:40.892673 ignition[1205]: INFO : reading system config file "/usr/lib/ignition/user.ign"
Feb 9 09:44:40.892673 ignition[1205]: INFO : no config at "/usr/lib/ignition/user.ign"
Feb 9 09:44:40.892673 ignition[1205]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Feb 9 09:44:40.901117 ignition[1205]: INFO : PUT result: OK
Feb 9 09:44:40.901117 ignition[1205]: INFO : GET http://169.254.169.254/2019-10-01/user-data: attempt #1
Feb 9 09:44:40.905237 ignition[1205]: INFO : GET result: OK
Feb 9 09:44:40.906688 ignition[1205]: DEBUG : parsing config with SHA512: a568ec1aae18acaadfdc4b8bf9ee213fe5a4e3cb600d7957646cd07aac87d49c9ca0d19633efaebfd4a99741b780222650406135ac3944d7c71be835b58cfcd5
Feb 9 09:44:40.921909 unknown[1205]: fetched base config from "system"
Feb 9 09:44:40.921942 unknown[1205]: fetched base config from "system"
Feb 9 09:44:40.921958 unknown[1205]: fetched user config from "aws"
Feb 9 09:44:40.927480 ignition[1205]: fetch: fetch complete
Feb 9 09:44:40.927505 ignition[1205]: fetch: fetch passed
Feb 9 09:44:40.930216 ignition[1205]: Ignition finished successfully
Feb 9 09:44:40.934141 systemd[1]: Finished ignition-fetch.service.
Feb 9 09:44:40.955850 kernel: audit: type=1130 audit(1707471880.934:29): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:40.934000 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'
Feb 9 09:44:40.937309 systemd[1]: Starting ignition-kargs.service...
Feb 9 09:44:40.966710 ignition[1211]: Ignition 2.14.0
Feb 9 09:44:40.968375 ignition[1211]: Stage: kargs
Feb 9 09:44:40.969842 ignition[1211]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Feb 9 09:44:40.972135 ignition[1211]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Feb 9 09:44:40.982424 ignition[1211]: no config dir at "/usr/lib/ignition/base.platform.d/aws"
Feb 9 09:44:40.985043 ignition[1211]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Feb 9 09:44:40.988215 ignition[1211]: INFO : PUT result: OK
Feb 9 09:44:41.004064 ignition[1211]: kargs: kargs passed
Feb 9 09:44:41.004170 ignition[1211]: Ignition finished successfully
Feb 9 09:44:41.008558 systemd[1]: Finished ignition-kargs.service.
Feb 9 09:44:41.007000 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'
Feb 9 09:44:41.021252 kernel: audit: type=1130 audit(1707471881.007:30): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:41.019436 systemd[1]: Starting ignition-disks.service...
Feb 9 09:44:41.033522 ignition[1217]: Ignition 2.14.0
Feb 9 09:44:41.035194 ignition[1217]: Stage: disks
Feb 9 09:44:41.036747 ignition[1217]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Feb 9 09:44:41.039074 ignition[1217]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Feb 9 09:44:41.049832 ignition[1217]: no config dir at "/usr/lib/ignition/base.platform.d/aws"
Feb 9 09:44:41.052502 ignition[1217]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Feb 9 09:44:41.055414 ignition[1217]: INFO : PUT result: OK
Feb 9 09:44:41.059998 ignition[1217]: disks: disks passed
Feb 9 09:44:41.060101 ignition[1217]: Ignition finished successfully
Feb 9 09:44:41.063715 systemd[1]: Finished ignition-disks.service.
Feb 9 09:44:41.077502 kernel: audit: type=1130 audit(1707471881.067:31): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:41.067000 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'
Feb 9 09:44:41.076972 systemd[1]: Reached target initrd-root-device.target.
Feb 9 09:44:41.079244 systemd[1]: Reached target local-fs-pre.target.
Feb 9 09:44:41.080930 systemd[1]: Reached target local-fs.target.
Feb 9 09:44:41.082550 systemd[1]: Reached target sysinit.target.
Feb 9 09:44:41.084272 systemd[1]: Reached target basic.target.
Feb 9 09:44:41.090146 systemd[1]: Starting systemd-fsck-root.service...
Feb 9 09:44:41.131641 systemd-fsck[1225]: ROOT: clean, 602/553520 files, 56013/553472 blocks
Feb 9 09:44:41.140256 systemd[1]: Finished systemd-fsck-root.service.
Feb 9 09:44:41.139000 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'
Feb 9 09:44:41.151183 systemd[1]: Mounting sysroot.mount...
Feb 9 09:44:41.156424 kernel: audit: type=1130 audit(1707471881.139:32): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:41.173405 kernel: EXT4-fs (nvme0n1p9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
Feb 9 09:44:41.174696 systemd[1]: Mounted sysroot.mount.
Feb 9 09:44:41.175761 systemd[1]: Reached target initrd-root-fs.target.
Feb 9 09:44:41.178755 systemd[1]: Mounting sysroot-usr.mount...
Feb 9 09:44:41.187949 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met.
Feb 9 09:44:41.188043 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
Feb 9 09:44:41.188098 systemd[1]: Reached target ignition-diskful.target.
Feb 9 09:44:41.191724 systemd[1]: Mounted sysroot-usr.mount.
Feb 9 09:44:41.207057 systemd[1]: Mounting sysroot-usr-share-oem.mount...
Feb 9 09:44:41.215541 systemd[1]: Starting initrd-setup-root.service...
Feb 9 09:44:41.231371 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by mount (1242)
Feb 9 09:44:41.237559 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm
Feb 9 09:44:41.237613 kernel: BTRFS info (device nvme0n1p6): using free space tree
Feb 9 09:44:41.237638 initrd-setup-root[1247]: cut: /sysroot/etc/passwd: No such file or directory
Feb 9 09:44:41.243572 kernel: BTRFS info (device nvme0n1p6): has skinny extents
Feb 9 09:44:41.252375 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations
Feb 9 09:44:41.256141 systemd[1]: Mounted sysroot-usr-share-oem.mount.
Feb 9 09:44:41.267219 initrd-setup-root[1273]: cut: /sysroot/etc/group: No such file or directory
Feb 9 09:44:41.275153 initrd-setup-root[1281]: cut: /sysroot/etc/shadow: No such file or directory
Feb 9 09:44:41.283025 initrd-setup-root[1289]: cut: /sysroot/etc/gshadow: No such file or directory
Feb 9 09:44:41.440517 systemd-networkd[1181]: eth0: Gained IPv6LL
Feb 9 09:44:41.490568 systemd[1]: Finished initrd-setup-root.service.
Feb 9 09:44:41.492000 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'
Feb 9 09:44:41.495076 systemd[1]: Starting ignition-mount.service...
Feb 9 09:44:41.505371 kernel: audit: type=1130 audit(1707471881.492:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:41.506267 systemd[1]: Starting sysroot-boot.service...
Feb 9 09:44:41.517442 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully.
Feb 9 09:44:41.517612 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully.
Feb 9 09:44:41.545383 ignition[1308]: INFO : Ignition 2.14.0
Feb 9 09:44:41.547567 ignition[1308]: INFO : Stage: mount
Feb 9 09:44:41.547567 ignition[1308]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"
Feb 9 09:44:41.547567 ignition[1308]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Feb 9 09:44:41.565592 ignition[1308]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws"
Feb 9 09:44:41.565592 ignition[1308]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Feb 9 09:44:41.571051 ignition[1308]: INFO : PUT result: OK
Feb 9 09:44:41.575317 ignition[1308]: INFO : mount: mount passed
Feb 9 09:44:41.576969 ignition[1308]: INFO : Ignition finished successfully
Feb 9 09:44:41.581570 systemd[1]: Finished sysroot-boot.service.
Feb 9 09:44:41.584000 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'
Feb 9 09:44:41.585392 systemd[1]: Finished ignition-mount.service.
Feb 9 09:44:41.595616 kernel: audit: type=1130 audit(1707471881.584:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:41.594000 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'
Feb 9 09:44:41.596953 systemd[1]: Starting ignition-files.service...
Feb 9 09:44:41.612285 systemd[1]: Mounting sysroot-usr-share-oem.mount...
Feb 9 09:44:41.619947 kernel: audit: type=1130 audit(1707471881.594:35): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:41.631396 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by mount (1318)
Feb 9 09:44:41.637130 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm
Feb 9 09:44:41.637164 kernel: BTRFS info (device nvme0n1p6): using free space tree
Feb 9 09:44:41.637188 kernel: BTRFS info (device nvme0n1p6): has skinny extents
Feb 9 09:44:41.646378 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations
Feb 9 09:44:41.651010 systemd[1]: Mounted sysroot-usr-share-oem.mount.
Feb 9 09:44:41.670111 ignition[1337]: INFO : Ignition 2.14.0
Feb 9 09:44:41.670111 ignition[1337]: INFO : Stage: files
Feb 9 09:44:41.674019 ignition[1337]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"
Feb 9 09:44:41.674019 ignition[1337]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Feb 9 09:44:41.688756 ignition[1337]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws"
Feb 9 09:44:41.688756 ignition[1337]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Feb 9 09:44:41.695404 ignition[1337]: INFO : PUT result: OK
Feb 9 09:44:41.700111 ignition[1337]: DEBUG : files: compiled without relabeling support, skipping
Feb 9 09:44:41.704052 ignition[1337]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core"
Feb 9 09:44:41.706838 ignition[1337]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
Feb 9 09:44:41.772276 ignition[1337]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core"
Feb 9 09:44:41.775373 ignition[1337]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core"
Feb 9 09:44:41.779117 unknown[1337]: wrote ssh authorized keys file for user: core
Feb 9 09:44:41.781445 ignition[1337]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
Feb 9 09:44:41.785005 ignition[1337]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/eks/bootstrap.sh"
Feb 9 09:44:41.789386 ignition[1337]: INFO : oem config not found in "/usr/share/oem", looking on oem partition
Feb 9 09:44:41.806303 ignition[1337]: INFO : op(1): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem738660863"
Feb 9 09:44:41.809225 ignition[1337]: CRITICAL : op(1): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem738660863": device or resource busy
Feb 9 09:44:41.812517 ignition[1337]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem738660863", trying btrfs: device or resource busy
Feb 9 09:44:41.816007 ignition[1337]: INFO : op(2): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem738660863"
Feb 9 09:44:41.822607 ignition[1337]: INFO : op(2): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem738660863"
Feb 9 09:44:41.825328 kernel: BTRFS info: devid 1 device path /dev/nvme0n1p6 changed to /dev/disk/by-label/OEM scanned by ignition (1337)
Feb 9 09:44:41.836355 ignition[1337]: INFO : op(3): [started] unmounting "/mnt/oem738660863"
Feb 9 09:44:41.838649 ignition[1337]: INFO : op(3): [finished] unmounting "/mnt/oem738660863"
Feb 9 09:44:41.838649 ignition[1337]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/eks/bootstrap.sh"
Feb 9 09:44:41.844576 ignition[1337]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf"
Feb 9 09:44:41.848224 ignition[1337]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf"
Feb 9 09:44:41.851754 ignition[1337]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json"
Feb 9 09:44:41.855485 ignition[1337]: INFO : oem config not found in "/usr/share/oem", looking on oem partition
Feb 9 09:44:41.864469 ignition[1337]: INFO : op(4): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem558190267"
Feb 9 09:44:41.864469 ignition[1337]: CRITICAL : op(4): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem558190267": device or resource busy
Feb 9 09:44:41.864469 ignition[1337]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem558190267", trying btrfs: device or resource busy
Feb 9 09:44:41.864469 ignition[1337]: INFO : op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem558190267"
Feb 9 09:44:41.864469 ignition[1337]: INFO : op(5): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem558190267"
Feb 9 09:44:41.881181 ignition[1337]: INFO : op(6): [started] unmounting "/mnt/oem558190267"
Feb 9 09:44:41.881181 ignition[1337]: INFO : op(6): [finished] unmounting "/mnt/oem558190267"
Feb 9 09:44:41.881181 ignition[1337]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json"
Feb 9 09:44:41.881181 ignition[1337]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/amazon/ssm/seelog.xml"
Feb 9 09:44:41.881181 ignition[1337]: INFO : oem config not found in "/usr/share/oem", looking on oem partition
Feb 9 09:44:41.904274 ignition[1337]: INFO : op(7): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1461041815"
Feb 9 09:44:41.907187 ignition[1337]: CRITICAL : op(7): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1461041815": device or resource busy
Feb 9 09:44:41.907187 ignition[1337]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem1461041815", trying btrfs: device or resource busy
Feb 9 09:44:41.907187 ignition[1337]: INFO : op(8): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1461041815"
Feb 9 09:44:41.907187 ignition[1337]: INFO : op(8): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1461041815"
Feb 9 09:44:41.907187 ignition[1337]: INFO : op(9): [started] unmounting "/mnt/oem1461041815"
Feb 9 09:44:41.931621 ignition[1337]: INFO : op(9): [finished] unmounting "/mnt/oem1461041815"
Feb 9 09:44:41.931621 ignition[1337]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/amazon/ssm/seelog.xml"
Feb 9 09:44:41.931621 ignition[1337]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/etc/systemd/system/nvidia.service"
Feb 9 09:44:41.931621 ignition[1337]: INFO : oem config not found in "/usr/share/oem", looking on oem partition
Feb 9 09:44:41.943781 ignition[1337]: INFO : op(a): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem960472181"
Feb 9 09:44:41.943781 ignition[1337]: CRITICAL : op(a): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem960472181": device or resource busy
Feb 9 09:44:41.943781 ignition[1337]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem960472181", trying btrfs: device or resource busy
Feb 9 09:44:41.943781 ignition[1337]: INFO : op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem960472181"
Feb 9 09:44:41.966419 ignition[1337]: INFO : op(b): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem960472181"
Feb 9 09:44:41.966419 ignition[1337]: INFO : op(c): [started] unmounting "/mnt/oem960472181"
Feb 9 09:44:41.966419 ignition[1337]: INFO : op(c): [finished] unmounting "/mnt/oem960472181"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(8): [started] processing unit "coreos-metadata-sshkeys@.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(8): [finished] processing unit "coreos-metadata-sshkeys@.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(9): [started] processing unit "amazon-ssm-agent.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(9): op(a): [started] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(9): op(a): [finished] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(9): [finished] processing unit "amazon-ssm-agent.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(b): [started] processing unit "nvidia.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(b): [finished] processing unit "nvidia.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(c): [started] processing unit "etcd-member.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(c): op(d): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(c): op(d): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(c): [finished] processing unit "etcd-member.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(e): [started] setting preset to enabled for "nvidia.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(e): [finished] setting preset to enabled for "nvidia.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(f): [started] setting preset to enabled for "etcd-member.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(f): [finished] setting preset to enabled for "etcd-member.service"
Feb 9 09:44:41.966419 ignition[1337]: INFO : files: op(10): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service "
Feb 9 09:44:42.063425 kernel: audit: type=1130 audit(1707471881.988:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:41.988000 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'
Feb 9 09:44:42.063567 ignition[1337]: INFO : files: op(10): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service "
Feb 9 09:44:42.063567 ignition[1337]: INFO : files: op(11): [started] setting preset to enabled for "amazon-ssm-agent.service"
Feb 9 09:44:42.063567 ignition[1337]: INFO : files: op(11): [finished] setting preset to enabled for "amazon-ssm-agent.service"
Feb 9 09:44:42.063567 ignition[1337]: INFO : files: createResultFile: createFiles: op(12): [started] writing file "/sysroot/etc/.ignition-result.json"
Feb 9 09:44:42.063567 ignition[1337]: INFO : files: createResultFile: createFiles: op(12): [finished] writing file "/sysroot/etc/.ignition-result.json"
Feb 9 09:44:42.063567 ignition[1337]: INFO : files: files passed
Feb 9 09:44:42.063567 ignition[1337]: INFO : Ignition finished successfully
Feb 9 09:44:41.971011 systemd[1]: Finished ignition-files.service.
Feb 9 09:44:41.998783 systemd[1]: Starting initrd-setup-root-after-ignition.service...
Feb 9 09:44:42.052152 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile).
Feb 9 09:44:42.104929 kernel: audit: type=1130 audit(1707471882.092:37): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:42.092000 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'
Feb 9 09:44:42.092000 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'
Feb 9 09:44:42.083013 systemd[1]: Starting ignition-quench.service...
Feb 9 09:44:42.090181 systemd[1]: ignition-quench.service: Deactivated successfully.
Feb 9 09:44:42.092222 systemd[1]: Finished ignition-quench.service.
Feb 9 09:44:42.110702 initrd-setup-root-after-ignition[1360]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Feb 9 09:44:42.117906 systemd[1]: Finished initrd-setup-root-after-ignition.service.
Feb 9 09:44:42.120000 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'
Feb 9 09:44:42.121932 systemd[1]: Reached target ignition-complete.target.
Feb 9 09:44:42.126628 systemd[1]: Starting initrd-parse-etc.service...
Feb 9 09:44:42.155548 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
Feb 9 09:44:42.157802 systemd[1]: Finished initrd-parse-etc.service.
Feb 9 09:44:42.159000 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'
Feb 9 09:44:42.159000 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'
Feb 9 09:44:42.161579 systemd[1]: Reached target initrd-fs.target.
Feb 9 09:44:42.164893 systemd[1]: Reached target initrd.target.
Feb 9 09:44:42.168035 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met.
Feb 9 09:44:42.172076 systemd[1]: Starting dracut-pre-pivot.service...
Feb 9 09:44:42.198627 systemd[1]: Finished dracut-pre-pivot.service.
Feb 9 09:44:42.197000 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'
Feb 9 09:44:42.202495 systemd[1]: Starting initrd-cleanup.service...
Feb 9 09:44:42.226080 systemd[1]: Stopped target nss-lookup.target.
Feb 9 09:44:42.229249 systemd[1]: Stopped target remote-cryptsetup.target.
Feb 9 09:44:42.241766 systemd[1]: Stopped target timers.target.
Feb 9 09:44:42.245513 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
Feb 9 09:44:42.247000 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'
Feb 9 09:44:42.267000 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'
Feb 9 09:44:42.271000 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'
Feb 9 09:44:42.273000 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'
Feb 9 09:44:42.275000 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'
Feb 9 09:44:42.291000 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'
Feb 9 09:44:42.245619 systemd[1]: Stopped dracut-pre-pivot.service.
Feb 9 09:44:42.248860 systemd[1]: Stopped target initrd.target.
Feb 9 09:44:42.250413 systemd[1]: Stopped target basic.target.
Feb 9 09:44:42.307000 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'
Feb 9 09:44:42.309000 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'
Feb 9 09:44:42.314000 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'
Feb 9 09:44:42.317000 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'
Feb 9 09:44:42.317000 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'
Feb 9 09:44:42.251947 systemd[1]: Stopped target ignition-complete.target.
Feb 9 09:44:42.253733 systemd[1]: Stopped target ignition-diskful.target.
Feb 9 09:44:42.255491 systemd[1]: Stopped target initrd-root-device.target.
Feb 9 09:44:42.257374 systemd[1]: Stopped target remote-fs.target.
Feb 9 09:44:42.259060 systemd[1]: Stopped target remote-fs-pre.target.
Feb 9 09:44:42.260785 systemd[1]: Stopped target sysinit.target.
Feb 9 09:44:42.262442 systemd[1]: Stopped target local-fs.target.
Feb 9 09:44:42.264115 systemd[1]: Stopped target local-fs-pre.target.
Feb 9 09:44:42.265798 systemd[1]: Stopped target swap.target.
Feb 9 09:44:42.267354 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
Feb 9 09:44:42.267443 systemd[1]: Stopped dracut-pre-mount.service.
Feb 9 09:44:42.269243 systemd[1]: Stopped target cryptsetup.target.
Feb 9 09:44:42.270924 systemd[1]: dracut-initqueue.service: Deactivated successfully.
Feb 9 09:44:42.271001 systemd[1]: Stopped dracut-initqueue.service.
Feb 9 09:44:42.366204 ignition[1375]: INFO : Ignition 2.14.0
Feb 9 09:44:42.366204 ignition[1375]: INFO : Stage: umount
Feb 9 09:44:42.366204 ignition[1375]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"
Feb 9 09:44:42.366204 ignition[1375]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Feb 9 09:44:42.366000 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'
Feb 9 09:44:42.272795 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
Feb 9 09:44:42.272873 systemd[1]: Stopped initrd-setup-root-after-ignition.service.
Feb 9 09:44:42.274961 systemd[1]: ignition-files.service: Deactivated successfully.
Feb 9 09:44:42.275037 systemd[1]: Stopped ignition-files.service.
Feb 9 09:44:42.277935 systemd[1]: Stopping ignition-mount.service...
Feb 9 09:44:42.287712 systemd[1]: Stopping iscsiuio.service...
Feb 9 09:44:42.289071 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
Feb 9 09:44:42.289281 systemd[1]: Stopped kmod-static-nodes.service.
Feb 9 09:44:42.295840 systemd[1]: Stopping sysroot-boot.service...
Feb 9 09:44:42.303690 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
Feb 9 09:44:42.304301 systemd[1]: Stopped systemd-udev-trigger.service.
Feb 9 09:44:42.309295 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
Feb 9 09:44:42.309430 systemd[1]: Stopped dracut-pre-trigger.service.
Feb 9 09:44:42.312249 systemd[1]: iscsiuio.service: Deactivated successfully.
Feb 9 09:44:42.313937 systemd[1]: Stopped iscsiuio.service.
Feb 9 09:44:42.316017 systemd[1]: initrd-cleanup.service: Deactivated successfully.
Feb 9 09:44:42.316804 systemd[1]: Finished initrd-cleanup.service.
Feb 9 09:44:42.333766 systemd[1]: sysroot-boot.mount: Deactivated successfully.
Feb 9 09:44:42.362231 systemd[1]: sysroot-boot.service: Deactivated successfully.
Feb 9 09:44:42.362450 systemd[1]: Stopped sysroot-boot.service.
Feb 9 09:44:42.420004 ignition[1375]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws"
Feb 9 09:44:42.423658 ignition[1375]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Feb 9 09:44:42.426480 ignition[1375]: INFO : PUT result: OK
Feb 9 09:44:42.430944 ignition[1375]: INFO : umount: umount passed
Feb 9 09:44:42.432702 ignition[1375]: INFO : Ignition finished successfully
Feb 9 09:44:42.435870 systemd[1]: ignition-mount.service: Deactivated successfully.
Feb 9 09:44:42.436270 systemd[1]: Stopped ignition-mount.service.
Feb 9 09:44:42.438000 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'
Feb 9 09:44:42.439000 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'
Feb 9 09:44:42.442000 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'
Feb 9 09:44:42.444000 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'
Feb 9 09:44:42.439590 systemd[1]: ignition-disks.service: Deactivated successfully.
Feb 9 09:44:42.439675 systemd[1]: Stopped ignition-disks.service.
Feb 9 09:44:42.449000 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'
Feb 9 09:44:42.441544 systemd[1]: ignition-kargs.service: Deactivated successfully.
Feb 9 09:44:42.441624 systemd[1]: Stopped ignition-kargs.service.
Feb 9 09:44:42.444333 systemd[1]: ignition-fetch.service: Deactivated successfully.
Feb 9 09:44:42.444428 systemd[1]: Stopped ignition-fetch.service.
Feb 9 09:44:42.446130 systemd[1]: Stopped target network.target.
Feb 9 09:44:42.469000 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'
Feb 9 09:44:42.470000 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'
Feb 9 09:44:42.447766 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
Feb 9 09:44:42.448034 systemd[1]: Stopped ignition-fetch-offline.service.
Feb 9 09:44:42.451315 systemd[1]: Stopped target paths.target.
Feb 9 09:44:42.452832 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
Feb 9 09:44:42.485000 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'
Feb 9 09:44:42.493000 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'
Feb 9 09:44:42.494000 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'
Feb 9 09:44:42.499000 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'
Feb 9 09:44:42.456411 systemd[1]: Stopped systemd-ask-password-console.path.
Feb 9 09:44:42.457886 systemd[1]: Stopped target slices.target.
Feb 9 09:44:42.462803 systemd[1]: Stopped target sockets.target.
Feb 9 09:44:42.464450 systemd[1]: iscsid.socket: Deactivated successfully.
Feb 9 09:44:42.464504 systemd[1]: Closed iscsid.socket.
Feb 9 09:44:42.467326 systemd[1]: iscsiuio.socket: Deactivated successfully.
Feb 9 09:44:42.467413 systemd[1]: Closed iscsiuio.socket.
Feb 9 09:44:42.520000 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'
Feb 9 09:44:42.468862 systemd[1]: ignition-setup.service: Deactivated successfully.
Feb 9 09:44:42.468943 systemd[1]: Stopped ignition-setup.service.
Feb 9 09:44:42.470613 systemd[1]: initrd-setup-root.service: Deactivated successfully.
Feb 9 09:44:42.526000 audit: BPF prog-id=6 op=UNLOAD
Feb 9 09:44:42.470689 systemd[1]: Stopped initrd-setup-root.service.
Feb 9 09:44:42.472765 systemd[1]: Stopping systemd-networkd.service...
Feb 9 09:44:42.533000 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'
Feb 9 09:44:42.474391 systemd[1]: Stopping systemd-resolved.service...
Feb 9 09:44:42.482411 systemd-networkd[1181]: eth0: DHCPv6 lease lost
Feb 9 09:44:42.537000 audit: BPF prog-id=9 op=UNLOAD
Feb 9 09:44:42.484157 systemd[1]: systemd-networkd.service: Deactivated successfully.
Feb 9 09:44:42.484425 systemd[1]: Stopped systemd-networkd.service.
Feb 9 09:44:42.487216 systemd[1]: systemd-networkd.socket: Deactivated successfully.
Feb 9 09:44:42.487287 systemd[1]: Closed systemd-networkd.socket.
Feb 9 09:44:42.490057 systemd[1]: Stopping network-cleanup.service...
Feb 9 09:44:42.492839 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
Feb 9 09:44:42.548000 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'
Feb 9 09:44:42.492952 systemd[1]: Stopped parse-ip-for-networkd.service.
Feb 9 09:44:42.494842 systemd[1]: systemd-sysctl.service: Deactivated successfully.
Feb 9 09:44:42.494926 systemd[1]: Stopped systemd-sysctl.service.
Feb 9 09:44:42.498356 systemd[1]: systemd-modules-load.service: Deactivated successfully.
Feb 9 09:44:42.498443 systemd[1]: Stopped systemd-modules-load.service.
Feb 9 09:44:42.508467 systemd[1]: Stopping systemd-udevd.service...
Feb 9 09:44:42.515791 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully.
Feb 9 09:44:42.518016 systemd[1]: systemd-resolved.service: Deactivated successfully.
Feb 9 09:44:42.518263 systemd[1]: Stopped systemd-resolved.service.
Feb 9 09:44:42.532521 systemd[1]: network-cleanup.service: Deactivated successfully.
Feb 9 09:44:42.532781 systemd[1]: Stopped network-cleanup.service.
Feb 9 09:44:42.538541 systemd[1]: systemd-udevd.service: Deactivated successfully.
Feb 9 09:44:42.548389 systemd[1]: Stopped systemd-udevd.service.
Feb 9 09:44:42.574450 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
Feb 9 09:44:42.574548 systemd[1]: Closed systemd-udevd-control.socket.
Feb 9 09:44:42.579862 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
Feb 9 09:44:42.579946 systemd[1]: Closed systemd-udevd-kernel.socket.
Feb 9 09:44:42.583491 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
Feb 9 09:44:42.586905 systemd[1]: Stopped dracut-pre-udev.service.
Feb 9 09:44:42.588000 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'
Feb 9 09:44:42.589932 systemd[1]: dracut-cmdline.service: Deactivated successfully.
Feb 9 09:44:42.590015 systemd[1]: Stopped dracut-cmdline.service.
Feb 9 09:44:42.593000 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'
Feb 9 09:44:42.595028 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Feb 9 09:44:42.595113 systemd[1]: Stopped dracut-cmdline-ask.service.
Feb 9 09:44:42.598000 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'
Feb 9 09:44:42.601653 systemd[1]: Starting initrd-udevadm-cleanup-db.service...
Feb 9 09:44:42.622000 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'
Feb 9 09:44:42.623000 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'
Feb 9 09:44:42.623000 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'
Feb 9 09:44:42.621577 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Feb 9 09:44:42.621693 systemd[1]: Stopped systemd-vconsole-setup.service.
Feb 9 09:44:42.624162 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
Feb 9 09:44:42.624338 systemd[1]: Finished initrd-udevadm-cleanup-db.service.
Feb 9 09:44:42.625100 systemd[1]: Reached target initrd-switch-root.target.
Feb 9 09:44:42.628453 systemd[1]: Starting initrd-switch-root.service...
Feb 9 09:44:42.657705 systemd[1]: Switching root.
Feb 9 09:44:42.690468 iscsid[1186]: iscsid shutting down.
Feb 9 09:44:42.692067 systemd-journald[309]: Received SIGTERM from PID 1 (systemd).
Feb 9 09:44:42.692150 systemd-journald[309]: Journal stopped
Feb 9 09:44:48.751197 kernel: SELinux: Class mctp_socket not defined in policy.
Feb 9 09:44:48.751306 kernel: SELinux: Class anon_inode not defined in policy.
Feb 9 09:44:48.751341 kernel: SELinux: the above unknown classes and permissions will be allowed
Feb 9 09:44:48.751393 kernel: SELinux: policy capability network_peer_controls=1
Feb 9 09:44:48.751425 kernel: SELinux: policy capability open_perms=1
Feb 9 09:44:48.751457 kernel: SELinux: policy capability extended_socket_class=1
Feb 9 09:44:48.751488 kernel: SELinux: policy capability always_check_network=0
Feb 9 09:44:48.751521 kernel: SELinux: policy capability cgroup_seclabel=1
Feb 9 09:44:48.751552 kernel: SELinux: policy capability nnp_nosuid_transition=1
Feb 9 09:44:48.751581 kernel: SELinux: policy capability genfs_seclabel_symlinks=0
Feb 9 09:44:48.751609 kernel: SELinux: policy capability ioctl_skip_cloexec=0
Feb 9 09:44:48.751641 systemd[1]: Successfully loaded SELinux policy in 106.267ms.
Feb 9 09:44:48.751704 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 19.648ms.
Feb 9 09:44:48.751736 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)
Feb 9 09:44:48.751772 systemd[1]: Detected virtualization amazon.
Feb 9 09:44:48.751804 systemd[1]: Detected architecture arm64.
Feb 9 09:44:48.751835 systemd[1]: Detected first boot.
Feb 9 09:44:48.751867 systemd[1]: Initializing machine ID from VM UUID.
Feb 9 09:44:48.751896 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped).
Feb 9 09:44:48.751928 systemd[1]: Populated /etc with preset unit settings.
Feb 9 09:44:48.751969 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon.
Feb 9 09:44:48.752006 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon.
Feb 9 09:44:48.752038 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.
Feb 9 09:44:48.752073 kernel: kauditd_printk_skb: 55 callbacks suppressed
Feb 9 09:44:48.752105 kernel: audit: type=1334 audit(1707471888.307:86): prog-id=12 op=LOAD
Feb 9 09:44:48.752136 kernel: audit: type=1334 audit(1707471888.307:87): prog-id=3 op=UNLOAD
Feb 9 09:44:48.752166 kernel: audit: type=1334 audit(1707471888.309:88): prog-id=13 op=LOAD
Feb 9 09:44:48.752197 kernel: audit: type=1334 audit(1707471888.312:89): prog-id=14 op=LOAD
Feb 9 09:44:48.752226 kernel: audit: type=1334 audit(1707471888.312:90): prog-id=4 op=UNLOAD
Feb 9 09:44:48.752255 systemd[1]: iscsid.service: Deactivated successfully.
Feb 9 09:44:48.752290 kernel: audit: type=1334 audit(1707471888.312:91): prog-id=5 op=UNLOAD
Feb 9 09:44:48.752318 systemd[1]: Stopped iscsid.service.
Feb 9 09:44:48.755903 kernel: audit: type=1334 audit(1707471888.314:92): prog-id=15 op=LOAD
Feb 9 09:44:48.755961 kernel: audit: type=1334 audit(1707471888.314:93): prog-id=12 op=UNLOAD
Feb 9 09:44:48.756057 kernel: audit: type=1334 audit(1707471888.317:94): prog-id=16 op=LOAD
Feb 9 09:44:48.756091 kernel: audit: type=1334 audit(1707471888.320:95): prog-id=17 op=LOAD
Feb 9 09:44:48.756125 systemd[1]: initrd-switch-root.service: Deactivated successfully.
Feb 9 09:44:48.756161 systemd[1]: Stopped initrd-switch-root.service.
Feb 9 09:44:48.756193 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
Feb 9 09:44:48.756230 systemd[1]: Created slice system-addon\x2dconfig.slice.
Feb 9 09:44:48.756263 systemd[1]: Created slice system-addon\x2drun.slice.
Feb 9 09:44:48.756297 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice.
Feb 9 09:44:48.756327 systemd[1]: Created slice system-getty.slice.
Feb 9 09:44:48.758180 systemd[1]: Created slice system-modprobe.slice.
Feb 9 09:44:48.758220 systemd[1]: Created slice system-serial\x2dgetty.slice.
Feb 9 09:44:48.758253 systemd[1]: Created slice system-system\x2dcloudinit.slice.
Feb 9 09:44:48.758291 systemd[1]: Created slice system-systemd\x2dfsck.slice.
Feb 9 09:44:48.758325 systemd[1]: Created slice user.slice.
Feb 9 09:44:48.758373 systemd[1]: Started systemd-ask-password-console.path.
Feb 9 09:44:48.758410 systemd[1]: Started systemd-ask-password-wall.path.
Feb 9 09:44:48.758442 systemd[1]: Set up automount boot.automount.
Feb 9 09:44:48.758472 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount.
Feb 9 09:44:48.758507 systemd[1]: Stopped target initrd-switch-root.target.
Feb 9 09:44:48.758540 systemd[1]: Stopped target initrd-fs.target.
Feb 9 09:44:48.758571 systemd[1]: Stopped target initrd-root-fs.target.
Feb 9 09:44:48.758607 systemd[1]: Reached target integritysetup.target.
Feb 9 09:44:48.758637 systemd[1]: Reached target remote-cryptsetup.target.
Feb 9 09:44:48.758668 systemd[1]: Reached target remote-fs.target.
Feb 9 09:44:48.758697 systemd[1]: Reached target slices.target.
Feb 9 09:44:48.758726 systemd[1]: Reached target swap.target.
Feb 9 09:44:48.758755 systemd[1]: Reached target torcx.target.
Feb 9 09:44:48.758790 systemd[1]: Reached target veritysetup.target.
Feb 9 09:44:48.758823 systemd[1]: Listening on systemd-coredump.socket.
Feb 9 09:44:48.758853 systemd[1]: Listening on systemd-initctl.socket.
Feb 9 09:44:48.758882 systemd[1]: Listening on systemd-networkd.socket.
Feb 9 09:44:48.758917 systemd[1]: Listening on systemd-udevd-control.socket.
Feb 9 09:44:48.758947 systemd[1]: Listening on systemd-udevd-kernel.socket.
Feb 9 09:44:48.758976 systemd[1]: Listening on systemd-userdbd.socket.
Feb 9 09:44:48.759005 systemd[1]: Mounting dev-hugepages.mount...
Feb 9 09:44:48.759036 systemd[1]: Mounting dev-mqueue.mount...
Feb 9 09:44:48.759065 systemd[1]: Mounting media.mount...
Feb 9 09:44:48.759095 systemd[1]: Mounting sys-kernel-debug.mount...
Feb 9 09:44:48.759124 systemd[1]: Mounting sys-kernel-tracing.mount...
Feb 9 09:44:48.759153 systemd[1]: Mounting tmp.mount...
Feb 9 09:44:48.759189 systemd[1]: Starting flatcar-tmpfiles.service...
Feb 9 09:44:48.759221 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met.
Feb 9 09:44:48.759253 systemd[1]: Starting kmod-static-nodes.service...
Feb 9 09:44:48.759282 systemd[1]: Starting modprobe@configfs.service...
Feb 9 09:44:48.759314 systemd[1]: Starting modprobe@dm_mod.service...
Feb 9 09:44:48.759389 systemd[1]: Starting modprobe@drm.service...
Feb 9 09:44:48.759439 systemd[1]: Starting modprobe@efi_pstore.service...
Feb 9 09:44:48.759473 systemd[1]: Starting modprobe@fuse.service...
Feb 9 09:44:48.759504 systemd[1]: Starting modprobe@loop.service...
Feb 9 09:44:48.759544 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
Feb 9 09:44:48.759575 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
Feb 9 09:44:48.759618 systemd[1]: Stopped systemd-fsck-root.service.
Feb 9 09:44:48.759648 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
Feb 9 09:44:48.759677 systemd[1]: Stopped systemd-fsck-usr.service.
Feb 9 09:44:48.759707 systemd[1]: Stopped systemd-journald.service.
Feb 9 09:44:48.759743 kernel: fuse: init (API version 7.34)
Feb 9 09:44:48.759772 systemd[1]: Starting systemd-journald.service...
Feb 9 09:44:48.759802 systemd[1]: Starting systemd-modules-load.service...
Feb 9 09:44:48.759836 systemd[1]: Starting systemd-network-generator.service...
Feb 9 09:44:48.759868 systemd[1]: Starting systemd-remount-fs.service...
Feb 9 09:44:48.759900 systemd[1]: Starting systemd-udev-trigger.service...
Feb 9 09:44:48.759933 systemd[1]: verity-setup.service: Deactivated successfully.
Feb 9 09:44:48.759964 systemd[1]: Stopped verity-setup.service.
Feb 9 09:44:48.759994 systemd[1]: Mounted dev-hugepages.mount.
Feb 9 09:44:48.760024 systemd[1]: Mounted dev-mqueue.mount.
Feb 9 09:44:48.760053 systemd[1]: Mounted media.mount.
Feb 9 09:44:48.760082 systemd[1]: Mounted sys-kernel-debug.mount.
Feb 9 09:44:48.760117 systemd[1]: Mounted sys-kernel-tracing.mount.
Feb 9 09:44:48.760148 systemd[1]: Mounted tmp.mount.
Feb 9 09:44:48.760178 systemd[1]: Finished kmod-static-nodes.service.
Feb 9 09:44:48.760209 systemd[1]: modprobe@configfs.service: Deactivated successfully.
Feb 9 09:44:48.760238 systemd[1]: Finished modprobe@configfs.service.
Feb 9 09:44:48.760271 kernel: loop: module loaded
Feb 9 09:44:48.760302 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Feb 9 09:44:48.760332 systemd[1]: Finished modprobe@dm_mod.service.
Feb 9 09:44:48.760399 systemd[1]: modprobe@drm.service: Deactivated successfully.
Feb 9 09:44:48.760439 systemd[1]: Finished modprobe@drm.service.
Feb 9 09:44:48.760472 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Feb 9 09:44:48.760502 systemd[1]: Finished modprobe@efi_pstore.service.
Feb 9 09:44:48.760532 systemd[1]: modprobe@fuse.service: Deactivated successfully.
Feb 9 09:44:48.760565 systemd[1]: Finished modprobe@fuse.service.
Feb 9 09:44:48.760600 systemd[1]: modprobe@loop.service: Deactivated successfully.
Feb 9 09:44:48.760637 systemd-journald[1490]: Journal started
Feb 9 09:44:48.760735 systemd-journald[1490]: Runtime Journal (/run/log/journal/ec2d7c527f3f1e3ada513676197c00ed) is 8.0M, max 75.4M, 67.4M free.
Feb 9 09:44:43.581000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1
Feb 9 09:44:43.806000 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
Feb 9 09:44:43.806000 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
Feb 9 09:44:43.806000 audit: BPF prog-id=10 op=LOAD
Feb 9 09:44:43.806000 audit: BPF prog-id=10 op=UNLOAD
Feb 9 09:44:43.806000 audit: BPF prog-id=11 op=LOAD
Feb 9 09:44:43.806000 audit: BPF prog-id=11 op=UNLOAD
Feb 9 09:44:44.017000 audit[1408]: AVC avc: denied { associate } for pid=1408 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"
Feb 9 09:44:44.017000 audit[1408]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=40001458b2 a1=40000c6de0 a2=40000cd0c0 a3=32 items=0 ppid=1391 pid=1408 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)
Feb 9 09:44:44.017000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61
Feb 9 09:44:44.020000 audit[1408]: AVC avc: denied { associate } for pid=1408 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
Feb 9 09:44:44.020000 audit[1408]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=4000145989 a2=1ed a3=0 items=2 ppid=1391 pid=1408 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)
Feb 9 09:44:44.020000 audit: CWD cwd="/"
Feb 9 09:44:44.020000 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
Feb 9 09:44:44.020000 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
Feb 9 09:44:44.020000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61
Feb 9 09:44:48.307000 audit: BPF prog-id=12 op=LOAD
Feb 9 09:44:48.307000 audit: BPF prog-id=3 op=UNLOAD
Feb 9 09:44:48.309000 audit: BPF prog-id=13 op=LOAD
Feb 9 09:44:48.312000 audit: BPF prog-id=14 op=LOAD
Feb 9 09:44:48.312000 audit: BPF prog-id=4 op=UNLOAD
Feb 9 09:44:48.312000 audit: BPF prog-id=5 op=UNLOAD
Feb 9 09:44:48.314000 audit: BPF prog-id=15 op=LOAD
Feb 9 09:44:48.314000 audit: BPF prog-id=12 op=UNLOAD
Feb 9 09:44:48.317000 audit: BPF prog-id=16 op=LOAD
Feb 9 09:44:48.320000 audit: BPF prog-id=17 op=LOAD
Feb 9 09:44:48.320000 audit: BPF prog-id=13 op=UNLOAD
Feb 9 09:44:48.320000 audit: BPF prog-id=14 op=UNLOAD
Feb 9 09:44:48.321000 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'
Feb 9 09:44:48.334000 audit: BPF prog-id=15 op=UNLOAD
Feb 9 09:44:48.340000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:44:48.348000 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'
Feb 9 09:44:48.348000 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'
Feb 9 09:44:48.610000 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'
Feb 9 09:44:48.620000 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'
Feb 9 09:44:48.625000 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'
Feb 9 09:44:48.625000 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'
Feb 9 09:44:48.627000 audit: BPF prog-id=18 op=LOAD
Feb 9 09:44:48.627000 audit: BPF prog-id=19 op=LOAD
Feb 9 09:44:48.627000 audit: BPF prog-id=20 op=LOAD
Feb 9 09:44:48.627000 audit: BPF prog-id=16 op=UNLOAD
Feb 9 09:44:48.627000 audit: BPF prog-id=17 op=UNLOAD
Feb 9 09:44:48.673000 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'
Feb 9 09:44:48.706000 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'
Feb 9 09:44:48.717000 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'
Feb 9 09:44:48.717000 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'
Feb 9 09:44:48.727000 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'
Feb 9 09:44:48.727000 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'
Feb 9 09:44:48.736000 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'
Feb 9 09:44:48.736000 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'
Feb 9 09:44:48.747000 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'
Feb 9 09:44:48.747000 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'
Feb 9 09:44:48.747000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1
Feb 9 09:44:48.747000 audit[1490]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=ffffd599f930 a2=4000 a3=1 items=0 ppid=1 pid=1490 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)
Feb 9 09:44:48.747000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald"
Feb 9 09:44:48.754000 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'
Feb 9 09:44:48.754000 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'
Feb 9 09:44:48.305030 systemd[1]: Queued start job for default target multi-user.target.
Feb 9 09:44:44.005057 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" 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.2 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.2 /var/lib/torcx/store]"
Feb 9 09:44:48.766457 systemd[1]: Finished modprobe@loop.service.
Feb 9 09:44:48.765000 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'
Feb 9 09:44:48.765000 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'
Feb 9 09:44:48.322645 systemd[1]: systemd-journald.service: Deactivated successfully.
Feb 9 09:44:44.015747 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json
Feb 9 09:44:44.015798 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json
Feb 9 09:44:44.015867 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12"
Feb 9 09:44:44.015897 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=debug msg="skipped missing lower profile" missing profile=oem
Feb 9 09:44:44.015961 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory"
Feb 9 09:44:44.015992 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)=
Feb 9 09:44:44.016437 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack
Feb 9 09:44:44.016522 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json
Feb 9 09:44:44.016560 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json
Feb 9 09:44:44.017383 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" 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
Feb 9 09:44:48.770493 systemd[1]: Started systemd-journald.service.
Feb 9 09:44:48.769000 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'
Feb 9 09:44:44.017484 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" 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
Feb 9 09:44:44.017532 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.2: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.2
Feb 9 09:44:44.017572 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store
Feb 9 09:44:44.017620 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.2: no such file or directory" path=/var/lib/torcx/store/3510.3.2
Feb 9 09:44:44.017661 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:44Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store
Feb 9 09:44:47.376607 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:47Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl
Feb 9 09:44:47.377140 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:47Z" 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
Feb 9 09:44:47.377418 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:47Z" 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
Feb 9 09:44:48.772000 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'
Feb 9 09:44:48.772042 systemd[1]: Finished systemd-modules-load.service.
Feb 9 09:44:47.377867 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:47Z" 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
Feb 9 09:44:47.377972 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:47Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile=
Feb 9 09:44:47.378108 /usr/lib/systemd/system-generators/torcx-generator[1408]: time="2024-02-09T09:44:47Z" 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
Feb 9 09:44:48.775000 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'
Feb 9 09:44:48.777000 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'
Feb 9 09:44:48.774635 systemd[1]: Finished systemd-network-generator.service.
Feb 9 09:44:48.777059 systemd[1]: Finished systemd-remount-fs.service.
Feb 9 09:44:48.780171 systemd[1]: Reached target network-pre.target.
Feb 9 09:44:48.784573 systemd[1]: Mounting sys-fs-fuse-connections.mount...
Feb 9 09:44:48.795962 systemd[1]: Mounting sys-kernel-config.mount...
Feb 9 09:44:48.800552 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
Feb 9 09:44:48.806940 systemd[1]: Starting systemd-hwdb-update.service...
Feb 9 09:44:48.811104 systemd[1]: Starting systemd-journal-flush.service...
Feb 9 09:44:48.812959 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Feb 9 09:44:48.815184 systemd[1]: Starting systemd-random-seed.service...
Feb 9 09:44:48.816963 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met.
Feb 9 09:44:48.819665 systemd[1]: Starting systemd-sysctl.service...
Feb 9 09:44:48.824412 systemd[1]: Mounted sys-fs-fuse-connections.mount.
Feb 9 09:44:48.826767 systemd[1]: Mounted sys-kernel-config.mount.
Feb 9 09:44:48.840021 systemd-journald[1490]: Time spent on flushing to /var/log/journal/ec2d7c527f3f1e3ada513676197c00ed is 69.142ms for 1109 entries.
Feb 9 09:44:48.840021 systemd-journald[1490]: System Journal (/var/log/journal/ec2d7c527f3f1e3ada513676197c00ed) is 8.0M, max 195.6M, 187.6M free.
Feb 9 09:44:48.940684 systemd-journald[1490]: Received client request to flush runtime journal.
Feb 9 09:44:48.889000 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'
Feb 9 09:44:48.904000 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'
Feb 9 09:44:48.936000 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'
Feb 9 09:44:48.888697 systemd[1]: Finished flatcar-tmpfiles.service.
Feb 9 09:44:48.942000 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'
Feb 9 09:44:48.894078 systemd[1]: Starting systemd-sysusers.service...
Feb 9 09:44:48.904159 systemd[1]: Finished systemd-random-seed.service.
Feb 9 09:44:48.906224 systemd[1]: Reached target first-boot-complete.target.
Feb 9 09:44:48.936164 systemd[1]: Finished systemd-sysctl.service.
Feb 9 09:44:48.942149 systemd[1]: Finished systemd-journal-flush.service.
Feb 9 09:44:48.972192 systemd[1]: Finished systemd-udev-trigger.service.
Feb 9 09:44:48.972000 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'
Feb 9 09:44:48.976222 systemd[1]: Starting systemd-udev-settle.service...
Feb 9 09:44:48.991297 udevadm[1527]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in.
Feb 9 09:44:49.071394 systemd[1]: Finished systemd-sysusers.service.
Feb 9 09:44:49.071000 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'
Feb 9 09:44:49.792587 systemd[1]: Finished systemd-hwdb-update.service.
Feb 9 09:44:49.795000 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'
Feb 9 09:44:49.796000 audit: BPF prog-id=21 op=LOAD
Feb 9 09:44:49.796000 audit: BPF prog-id=22 op=LOAD
Feb 9 09:44:49.796000 audit: BPF prog-id=7 op=UNLOAD
Feb 9 09:44:49.796000 audit: BPF prog-id=8 op=UNLOAD
Feb 9 09:44:49.799441 systemd[1]: Starting systemd-udevd.service...
Feb 9 09:44:49.838079 systemd-udevd[1528]: Using default interface naming scheme 'v252'.
Feb 9 09:44:49.877954 systemd[1]: Started systemd-udevd.service.
Feb 9 09:44:49.879000 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'
Feb 9 09:44:49.880000 audit: BPF prog-id=23 op=LOAD
Feb 9 09:44:49.885272 systemd[1]: Starting systemd-networkd.service...
Feb 9 09:44:49.889000 audit: BPF prog-id=24 op=LOAD
Feb 9 09:44:49.890000 audit: BPF prog-id=25 op=LOAD
Feb 9 09:44:49.890000 audit: BPF prog-id=26 op=LOAD
Feb 9 09:44:49.892725 systemd[1]: Starting systemd-userdbd.service...
Feb 9 09:44:49.964253 systemd[1]: Condition check resulted in dev-ttyS0.device being skipped.
Feb 9 09:44:49.987469 systemd[1]: Started systemd-userdbd.service.
Feb 9 09:44:49.987000 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'
Feb 9 09:44:50.006797 (udev-worker)[1544]: Network interface NamePolicy= disabled on kernel command line.
Feb 9 09:44:50.160137 systemd-networkd[1535]: lo: Link UP
Feb 9 09:44:50.161486 systemd-networkd[1535]: lo: Gained carrier
Feb 9 09:44:50.162659 systemd-networkd[1535]: Enumeration completed
Feb 9 09:44:50.163321 systemd[1]: Started systemd-networkd.service.
Feb 9 09:44:50.164228 systemd-networkd[1535]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Feb 9 09:44:50.164000 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'
Feb 9 09:44:50.169639 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Feb 9 09:44:50.169439 systemd[1]: Starting systemd-networkd-wait-online.service...
Feb 9 09:44:50.182059 systemd-networkd[1535]: eth0: Link UP
Feb 9 09:44:50.182619 systemd-networkd[1535]: eth0: Gained carrier
Feb 9 09:44:50.199694 systemd-networkd[1535]: eth0: DHCPv4 address 172.31.25.229/20, gateway 172.31.16.1 acquired from 172.31.16.1
Feb 9 09:44:50.223407 kernel: BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/nvme0n1p6 scanned by (udev-worker) (1539)
Feb 9 09:44:50.342709 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device.
Feb 9 09:44:50.345376 systemd[1]: Finished systemd-udev-settle.service.
Feb 9 09:44:50.345000 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'
Feb 9 09:44:50.349488 systemd[1]: Starting lvm2-activation-early.service...
Feb 9 09:44:50.397075 lvm[1647]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Feb 9 09:44:50.434924 systemd[1]: Finished lvm2-activation-early.service.
Feb 9 09:44:50.436984 systemd[1]: Reached target cryptsetup.target.
Feb 9 09:44:50.435000 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'
Feb 9 09:44:50.440785 systemd[1]: Starting lvm2-activation.service...
Feb 9 09:44:50.449279 lvm[1648]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Feb 9 09:44:50.487019 systemd[1]: Finished lvm2-activation.service.
Feb 9 09:44:50.487000 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'
Feb 9 09:44:50.489018 systemd[1]: Reached target local-fs-pre.target.
Feb 9 09:44:50.490862 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw).
Feb 9 09:44:50.490919 systemd[1]: Reached target local-fs.target.
Feb 9 09:44:50.492591 systemd[1]: Reached target machines.target.
Feb 9 09:44:50.496396 systemd[1]: Starting ldconfig.service...
Feb 9 09:44:50.498620 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met.
Feb 9 09:44:50.498794 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).
Feb 9 09:44:50.501091 systemd[1]: Starting systemd-boot-update.service...
Feb 9 09:44:50.505031 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service...
Feb 9 09:44:50.512485 systemd[1]: Starting systemd-machine-id-commit.service...
Feb 9 09:44:50.514562 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met.
Feb 9 09:44:50.514663 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met.
Feb 9 09:44:50.519106 systemd[1]: Starting systemd-tmpfiles-setup.service...
Feb 9 09:44:50.532177 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1650 (bootctl)
Feb 9 09:44:50.534565 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service...
Feb 9 09:44:50.572314 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service.
Feb 9 09:44:50.571000 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'
Feb 9 09:44:50.579413 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
Feb 9 09:44:50.581834 systemd[1]: Finished systemd-machine-id-commit.service.
Feb 9 09:44:50.580000 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'
Feb 9 09:44:50.620930 systemd-tmpfiles[1653]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring.
Feb 9 09:44:50.656798 systemd-tmpfiles[1653]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
Feb 9 09:44:50.663594 systemd-fsck[1658]: fsck.fat 4.2 (2021-01-31)
Feb 9 09:44:50.663594 systemd-fsck[1658]: /dev/nvme0n1p1: 236 files, 113719/258078 clusters
Feb 9 09:44:50.666637 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service.
Feb 9 09:44:50.667000 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'
Feb 9 09:44:50.671294 systemd[1]: Mounting boot.mount...
Feb 9 09:44:50.687408 systemd[1]: Mounted boot.mount.
Feb 9 09:44:50.695091 systemd-tmpfiles[1653]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
Feb 9 09:44:50.720936 systemd[1]: Finished systemd-boot-update.service.
Feb 9 09:44:50.721000 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'
Feb 9 09:44:50.969543 systemd[1]: Finished systemd-tmpfiles-setup.service.
Feb 9 09:44:50.970000 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'
Feb 9 09:44:50.973770 systemd[1]: Starting audit-rules.service...
Feb 9 09:44:50.977921 systemd[1]: Starting clean-ca-certificates.service...
Feb 9 09:44:50.982940 systemd[1]: Starting systemd-journal-catalog-update.service...
Feb 9 09:44:50.985000 audit: BPF prog-id=27 op=LOAD
Feb 9 09:44:50.992000 audit: BPF prog-id=28 op=LOAD
Feb 9 09:44:50.989663 systemd[1]: Starting systemd-resolved.service...
Feb 9 09:44:50.996740 systemd[1]: Starting systemd-timesyncd.service...
Feb 9 09:44:51.001969 systemd[1]: Starting systemd-update-utmp.service...
Feb 9 09:44:51.026045 systemd[1]: Finished clean-ca-certificates.service.
Feb 9 09:44:51.026000 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'
Feb 9 09:44:51.028221 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt).
Feb 9 09:44:51.035000 audit[1678]: SYSTEM_BOOT pid=1678 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'
Feb 9 09:44:51.044153 systemd[1]: Finished systemd-update-utmp.service.
Feb 9 09:44:51.045000 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'
Feb 9 09:44:51.077522 systemd[1]: Finished systemd-journal-catalog-update.service.
Feb 9 09:44:51.078000 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'
Feb 9 09:44:51.142000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1
Feb 9 09:44:51.142000 audit[1692]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffc3da93f0 a2=420 a3=0 items=0 ppid=1672 pid=1692 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)
Feb 9 09:44:51.142000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573
Feb 9 09:44:51.145578 augenrules[1692]: No rules
Feb 9 09:44:51.146753 systemd[1]: Finished audit-rules.service.
Feb 9 09:44:51.158676 systemd[1]: Started systemd-timesyncd.service.
Feb 9 09:44:51.160690 systemd[1]: Reached target time-set.target.
Feb 9 09:44:51.176679 systemd-resolved[1676]: Positive Trust Anchors:
Feb 9 09:44:51.177188 systemd-resolved[1676]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Feb 9 09:44:51.177376 systemd-resolved[1676]: 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
Feb 9 09:44:51.223492 systemd-resolved[1676]: Defaulting to hostname 'linux'.
Feb 9 09:44:51.226637 systemd[1]: Started systemd-resolved.service.
Feb 9 09:44:51.228559 systemd[1]: Reached target network.target.
Feb 9 09:44:51.230228 systemd[1]: Reached target nss-lookup.target.
Feb 9 09:44:51.352246 systemd-timesyncd[1677]: Contacted time server 15.204.87.223:123 (0.flatcar.pool.ntp.org).
Feb 9 09:44:51.352492 systemd-timesyncd[1677]: Initial clock synchronization to Fri 2024-02-09 09:44:51.297959 UTC.
Feb 9 09:44:51.566215 ldconfig[1649]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
Feb 9 09:44:51.584299 systemd[1]: Finished ldconfig.service.
Feb 9 09:44:51.588533 systemd[1]: Starting systemd-update-done.service...
Feb 9 09:44:51.602292 systemd[1]: Finished systemd-update-done.service.
Feb 9 09:44:51.604410 systemd[1]: Reached target sysinit.target.
Feb 9 09:44:51.606274 systemd[1]: Started motdgen.path.
Feb 9 09:44:51.607793 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path.
Feb 9 09:44:51.610304 systemd[1]: Started logrotate.timer.
Feb 9 09:44:51.611976 systemd[1]: Started mdadm.timer.
Feb 9 09:44:51.613470 systemd[1]: Started systemd-tmpfiles-clean.timer.
Feb 9 09:44:51.615305 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
Feb 9 09:44:51.615373 systemd[1]: Reached target paths.target.
Feb 9 09:44:51.616834 systemd[1]: Reached target timers.target.
Feb 9 09:44:51.618507 systemd-networkd[1535]: eth0: Gained IPv6LL
Feb 9 09:44:51.620698 systemd[1]: Listening on dbus.socket.
Feb 9 09:44:51.625521 systemd[1]: Starting docker.socket...
Feb 9 09:44:51.631762 systemd[1]: Listening on sshd.socket.
Feb 9 09:44:51.633784 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).
Feb 9 09:44:51.635078 systemd[1]: Finished systemd-networkd-wait-online.service.
Feb 9 09:44:51.637560 systemd[1]: Listening on docker.socket.
Feb 9 09:44:51.639473 systemd[1]: Reached target network-online.target.
Feb 9 09:44:51.641696 systemd[1]: Reached target sockets.target.
Feb 9 09:44:51.643457 systemd[1]: Reached target basic.target.
Feb 9 09:44:51.645226 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met.
Feb 9 09:44:51.645465 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met.
Feb 9 09:44:51.647712 systemd[1]: Started amazon-ssm-agent.service.
Feb 9 09:44:51.661607 systemd[1]: Starting containerd.service...
Feb 9 09:44:51.665804 systemd[1]: Starting coreos-metadata-sshkeys@core.service...
Feb 9 09:44:51.670774 systemd[1]: Starting coreos-metadata.service...
Feb 9 09:44:51.674962 systemd[1]: Starting dbus.service...
Feb 9 09:44:51.679960 systemd[1]: Starting enable-oem-cloudinit.service...
Feb 9 09:44:51.685048 systemd[1]: Starting extend-filesystems.service...
Feb 9 09:44:51.687145 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment).
Feb 9 09:44:51.689615 systemd[1]: Starting motdgen.service...
Feb 9 09:44:51.693437 systemd[1]: Started nvidia.service.
Feb 9 09:44:51.698280 systemd[1]: Starting ssh-key-proc-cmdline.service...
Feb 9 09:44:51.703581 systemd[1]: Starting sshd-keygen.service...
Feb 9 09:44:51.718012 systemd[1]: Starting systemd-logind.service...
Feb 9 09:44:51.719672 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f).
Feb 9 09:44:51.719787 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
Feb 9 09:44:51.720719 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
Feb 9 09:44:51.727359 systemd[1]: Starting update-engine.service...
Feb 9 09:44:51.733588 systemd[1]: Starting update-ssh-keys-after-ignition.service...
Feb 9 09:44:51.761572 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
Feb 9 09:44:51.852789 jq[1706]: false
Feb 9 09:44:51.761946 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped.
Feb 9 09:44:51.868834 jq[1715]: true
Feb 9 09:44:51.819897 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
Feb 9 09:44:51.820253 systemd[1]: Finished ssh-key-proc-cmdline.service.
Feb 9 09:44:51.873607 jq[1722]: true
Feb 9 09:44:51.953092 dbus-daemon[1705]: [system] SELinux support is enabled
Feb 9 09:44:51.953450 systemd[1]: Started dbus.service.
Feb 9 09:44:51.963138 extend-filesystems[1707]: Found nvme0n1
Feb 9 09:44:51.963138 extend-filesystems[1707]: Found nvme0n1p1
Feb 9 09:44:51.963138 extend-filesystems[1707]: Found nvme0n1p2
Feb 9 09:44:51.963138 extend-filesystems[1707]: Found nvme0n1p3
Feb 9 09:44:51.963138 extend-filesystems[1707]: Found usr
Feb 9 09:44:51.963138 extend-filesystems[1707]: Found nvme0n1p4
Feb 9 09:44:51.963138 extend-filesystems[1707]: Found nvme0n1p6
Feb 9 09:44:51.963138 extend-filesystems[1707]: Found nvme0n1p7
Feb 9 09:44:51.963138 extend-filesystems[1707]: Found nvme0n1p9
Feb 9 09:44:51.963138 extend-filesystems[1707]: Checking size of /dev/nvme0n1p9
Feb 9 09:44:51.958891 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).
Feb 9 09:44:51.968205 dbus-daemon[1705]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1535 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0")
Feb 9 09:44:51.958942 systemd[1]: Reached target system-config.target.
Feb 9 09:44:51.983573 dbus-daemon[1705]: [system] Successfully activated service 'org.freedesktop.systemd1'
Feb 9 09:44:51.960847 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url).
Feb 9 09:44:51.960890 systemd[1]: Reached target user-config.target.
Feb 9 09:44:52.006975 systemd[1]: Starting systemd-hostnamed.service...
Feb 9 09:44:52.015970 systemd[1]: motdgen.service: Deactivated successfully.
Feb 9 09:44:52.020467 systemd[1]: Finished motdgen.service.
Feb 9 09:44:52.085948 update_engine[1714]: I0209 09:44:52.085419 1714 main.cc:92] Flatcar Update Engine starting
Feb 9 09:44:52.091130 systemd[1]: Started update-engine.service.
Feb 9 09:44:52.091842 update_engine[1714]: I0209 09:44:52.091807 1714 update_check_scheduler.cc:74] Next update check in 10m54s
Feb 9 09:44:52.096019 systemd[1]: Started locksmithd.service.
Feb 9 09:44:52.107138 bash[1761]: Updated "/home/core/.ssh/authorized_keys"
Feb 9 09:44:52.108704 systemd[1]: Finished update-ssh-keys-after-ignition.service.
Feb 9 09:44:52.112502 extend-filesystems[1707]: Resized partition /dev/nvme0n1p9
Feb 9 09:44:52.121957 extend-filesystems[1771]: resize2fs 1.46.5 (30-Dec-2021)
Feb 9 09:44:52.159326 amazon-ssm-agent[1701]: 2024/02/09 09:44:52 Failed to load instance info from vault. RegistrationKey does not exist.
Feb 9 09:44:52.161256 amazon-ssm-agent[1701]: Initializing new seelog logger
Feb 9 09:44:52.161565 amazon-ssm-agent[1701]: New Seelog Logger Creation Complete
Feb 9 09:44:52.161674 amazon-ssm-agent[1701]: 2024/02/09 09:44:52 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json.
Feb 9 09:44:52.161674 amazon-ssm-agent[1701]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json.
Feb 9 09:44:52.162051 amazon-ssm-agent[1701]: 2024/02/09 09:44:52 processing appconfig overrides
Feb 9 09:44:52.162363 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks
Feb 9 09:44:52.207187 env[1719]: time="2024-02-09T09:44:52.207097022Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16
Feb 9 09:44:52.230380 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915
Feb 9 09:44:52.272645 extend-filesystems[1771]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required
Feb 9 09:44:52.272645 extend-filesystems[1771]: old_desc_blocks = 1, new_desc_blocks = 1
Feb 9 09:44:52.272645 extend-filesystems[1771]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long.
Feb 9 09:44:52.280045 extend-filesystems[1707]: Resized filesystem in /dev/nvme0n1p9
Feb 9 09:44:52.288090 systemd[1]: extend-filesystems.service: Deactivated successfully.
Feb 9 09:44:52.288474 systemd[1]: Finished extend-filesystems.service.
Feb 9 09:44:52.322712 systemd-logind[1713]: Watching system buttons on /dev/input/event0 (Power Button)
Feb 9 09:44:52.328619 systemd-logind[1713]: New seat seat0.
Feb 9 09:44:52.342920 systemd[1]: Started systemd-logind.service.
Feb 9 09:44:52.354372 env[1719]: time="2024-02-09T09:44:52.353967401Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Feb 9 09:44:52.355443 env[1719]: time="2024-02-09T09:44:52.355326896Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Feb 9 09:44:52.359913 env[1719]: time="2024-02-09T09:44:52.359822886Z" 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.148-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Feb 9 09:44:52.359913 env[1719]: time="2024-02-09T09:44:52.359903303Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Feb 9 09:44:52.360330 env[1719]: time="2024-02-09T09:44:52.360276051Z" 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
Feb 9 09:44:52.360330 env[1719]: time="2024-02-09T09:44:52.360327267Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Feb 9 09:44:52.360496 env[1719]: time="2024-02-09T09:44:52.360382653Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured"
Feb 9 09:44:52.360496 env[1719]: time="2024-02-09T09:44:52.360408708Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Feb 9 09:44:52.360619 env[1719]: time="2024-02-09T09:44:52.360589337Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Feb 9 09:44:52.361077 env[1719]: time="2024-02-09T09:44:52.361023635Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Feb 9 09:44:52.361320 env[1719]: time="2024-02-09T09:44:52.361267840Z" 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
Feb 9 09:44:52.361431 env[1719]: time="2024-02-09T09:44:52.361313524Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Feb 9 09:44:52.361492 env[1719]: time="2024-02-09T09:44:52.361452843Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured"
Feb 9 09:44:52.361492 env[1719]: time="2024-02-09T09:44:52.361482080Z" level=info msg="metadata content store policy set" policy=shared
Feb 9 09:44:52.373891 env[1719]: time="2024-02-09T09:44:52.373815868Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Feb 9 09:44:52.374074 env[1719]: time="2024-02-09T09:44:52.373898644Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Feb 9 09:44:52.374074 env[1719]: time="2024-02-09T09:44:52.373932804Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Feb 9 09:44:52.374074 env[1719]: time="2024-02-09T09:44:52.374027046Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Feb 9 09:44:52.374268 env[1719]: time="2024-02-09T09:44:52.374079441Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Feb 9 09:44:52.374268 env[1719]: time="2024-02-09T09:44:52.374112432Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Feb 9 09:44:52.374268 env[1719]: time="2024-02-09T09:44:52.374143838Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Feb 9 09:44:52.374705 env[1719]: time="2024-02-09T09:44:52.374655155Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Feb 9 09:44:52.374778 env[1719]: time="2024-02-09T09:44:52.374723140Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1
Feb 9 09:44:52.374778 env[1719]: time="2024-02-09T09:44:52.374758205Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Feb 9 09:44:52.374926 env[1719]: time="2024-02-09T09:44:52.374790136Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Feb 9 09:44:52.374926 env[1719]: time="2024-02-09T09:44:52.374820242Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Feb 9 09:44:52.375107 env[1719]: time="2024-02-09T09:44:52.375062004Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Feb 9 09:44:52.375307 env[1719]: time="2024-02-09T09:44:52.375263205Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Feb 9 09:44:52.375742 env[1719]: time="2024-02-09T09:44:52.375685703Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Feb 9 09:44:52.375833 env[1719]: time="2024-02-09T09:44:52.375758932Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.375833 env[1719]: time="2024-02-09T09:44:52.375796798Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Feb 9 09:44:52.375969 env[1719]: time="2024-02-09T09:44:52.375899086Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.375969 env[1719]: time="2024-02-09T09:44:52.375930420Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.375969 env[1719]: time="2024-02-09T09:44:52.375960622Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.376121 env[1719]: time="2024-02-09T09:44:52.375989216Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.376121 env[1719]: time="2024-02-09T09:44:52.376019966Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.376121 env[1719]: time="2024-02-09T09:44:52.376048941Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.376121 env[1719]: time="2024-02-09T09:44:52.376086342Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.376325 env[1719]: time="2024-02-09T09:44:52.376115531Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.376325 env[1719]: time="2024-02-09T09:44:52.376147617Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Feb 9 09:44:52.376527 env[1719]: time="2024-02-09T09:44:52.376481260Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.376596 env[1719]: time="2024-02-09T09:44:52.376532725Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.376596 env[1719]: time="2024-02-09T09:44:52.376565645Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.376702 env[1719]: time="2024-02-09T09:44:52.376594167Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Feb 9 09:44:52.376702 env[1719]: time="2024-02-09T09:44:52.376627408Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1
Feb 9 09:44:52.376702 env[1719]: time="2024-02-09T09:44:52.376657730Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Feb 9 09:44:52.376702 env[1719]: time="2024-02-09T09:44:52.376693760Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin"
Feb 9 09:44:52.376907 env[1719]: time="2024-02-09T09:44:52.376756799Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
Feb 9 09:44:52.377207 env[1719]: time="2024-02-09T09:44:52.377092838Z" 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}"
Feb 9 09:44:52.378256 env[1719]: time="2024-02-09T09:44:52.377209320Z" level=info msg="Connect containerd service"
Feb 9 09:44:52.378256 env[1719]: time="2024-02-09T09:44:52.377276483Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
Feb 9 09:44:52.379303 env[1719]: time="2024-02-09T09:44:52.379235137Z" 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"
Feb 9 09:44:52.379769 env[1719]: time="2024-02-09T09:44:52.379718039Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
Feb 9 09:44:52.379856 env[1719]: time="2024-02-09T09:44:52.379827073Z" level=info msg=serving... address=/run/containerd/containerd.sock
Feb 9 09:44:52.380029 systemd[1]: Started containerd.service.
Feb 9 09:44:52.382643 env[1719]: time="2024-02-09T09:44:52.382568673Z" level=info msg="Start subscribing containerd event"
Feb 9 09:44:52.382800 env[1719]: time="2024-02-09T09:44:52.382664715Z" level=info msg="Start recovering state"
Feb 9 09:44:52.382867 env[1719]: time="2024-02-09T09:44:52.382795941Z" level=info msg="Start event monitor"
Feb 9 09:44:52.382867 env[1719]: time="2024-02-09T09:44:52.382836835Z" level=info msg="Start snapshots syncer"
Feb 9 09:44:52.383001 env[1719]: time="2024-02-09T09:44:52.382861566Z" level=info msg="Start cni network conf syncer for default"
Feb 9 09:44:52.383001 env[1719]: time="2024-02-09T09:44:52.382880970Z" level=info msg="Start streaming server"
Feb 9 09:44:52.383218 env[1719]: time="2024-02-09T09:44:52.383166449Z" level=info msg="containerd successfully booted in 0.182554s"
Feb 9 09:44:52.440589 systemd[1]: nvidia.service: Deactivated successfully.
Feb 9 09:44:52.619293 dbus-daemon[1705]: [system] Successfully activated service 'org.freedesktop.hostname1'
Feb 9 09:44:52.619581 systemd[1]: Started systemd-hostnamed.service.
Feb 9 09:44:52.621369 dbus-daemon[1705]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1759 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0")
Feb 9 09:44:52.626534 systemd[1]: Starting polkit.service...
Feb 9 09:44:52.680472 polkitd[1858]: Started polkitd version 121
Feb 9 09:44:52.708133 polkitd[1858]: Loading rules from directory /etc/polkit-1/rules.d
Feb 9 09:44:52.712457 polkitd[1858]: Loading rules from directory /usr/share/polkit-1/rules.d
Feb 9 09:44:52.714086 polkitd[1858]: Finished loading, compiling and executing 2 rules
Feb 9 09:44:52.715646 dbus-daemon[1705]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Feb 9 09:44:52.715913 systemd[1]: Started polkit.service.
Feb 9 09:44:52.718444 polkitd[1858]: Acquired the name org.freedesktop.PolicyKit1 on the system bus
Feb 9 09:44:52.756405 systemd-resolved[1676]: System hostname changed to 'ip-172-31-25-229'.
Feb 9 09:44:52.756413 systemd-hostnamed[1759]: Hostname set to <ip-172-31-25-229> (transient)
Feb 9 09:44:52.791690 coreos-metadata[1703]: Feb 09 09:44:52.790 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1
Feb 9 09:44:52.792902 coreos-metadata[1703]: Feb 09 09:44:52.792 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys: Attempt #1
Feb 9 09:44:52.799078 coreos-metadata[1703]: Feb 09 09:44:52.798 INFO Fetch successful
Feb 9 09:44:52.799469 coreos-metadata[1703]: Feb 09 09:44:52.799 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys/0/openssh-key: Attempt #1
Feb 9 09:44:52.803171 coreos-metadata[1703]: Feb 09 09:44:52.802 INFO Fetch successful
Feb 9 09:44:52.805297 unknown[1703]: wrote ssh authorized keys file for user: core
Feb 9 09:44:52.839280 update-ssh-keys[1884]: Updated "/home/core/.ssh/authorized_keys"
Feb 9 09:44:52.840496 systemd[1]: Finished coreos-metadata-sshkeys@core.service.
Feb 9 09:44:52.867334 coreos-metadata[1704]: Feb 09 09:44:52.866 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1
Feb 9 09:44:52.870277 coreos-metadata[1704]: Feb 09 09:44:52.870 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/instance-id: Attempt #1
Feb 9 09:44:52.871194 coreos-metadata[1704]: Feb 09 09:44:52.870 INFO Fetch successful
Feb 9 09:44:52.871513 coreos-metadata[1704]: Feb 09 09:44:52.871 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/instance-type: Attempt #1
Feb 9 09:44:52.872297 coreos-metadata[1704]: Feb 09 09:44:52.872 INFO Fetch successful
Feb 9 09:44:52.872617 coreos-metadata[1704]: Feb 09 09:44:52.872 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/local-ipv4: Attempt #1
Feb 9 09:44:52.873468 coreos-metadata[1704]: Feb 09 09:44:52.873 INFO Fetch successful
Feb 9 09:44:52.873731 coreos-metadata[1704]: Feb 09 09:44:52.873 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-ipv4: Attempt #1
Feb 9 09:44:52.876012 coreos-metadata[1704]: Feb 09 09:44:52.875 INFO Fetch successful
Feb 9 09:44:52.876012 coreos-metadata[1704]: Feb 09 09:44:52.875 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/placement/availability-zone: Attempt #1
Feb 9 09:44:52.876867 coreos-metadata[1704]: Feb 09 09:44:52.876 INFO Fetch successful
Feb 9 09:44:52.876867 coreos-metadata[1704]: Feb 09 09:44:52.876 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/hostname: Attempt #1
Feb 9 09:44:52.877542 coreos-metadata[1704]: Feb 09 09:44:52.877 INFO Fetch successful
Feb 9 09:44:52.877847 coreos-metadata[1704]: Feb 09 09:44:52.877 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-hostname: Attempt #1
Feb 9 09:44:52.878281 coreos-metadata[1704]: Feb 09 09:44:52.878 INFO Fetch successful
Feb 9 09:44:52.878438 coreos-metadata[1704]: Feb 09 09:44:52.878 INFO Fetching http://169.254.169.254/2019-10-01/dynamic/instance-identity/document: Attempt #1
Feb 9 09:44:52.879223 coreos-metadata[1704]: Feb 09 09:44:52.879 INFO Fetch successful
Feb 9 09:44:52.896027 systemd[1]: Finished coreos-metadata.service.
Feb 9 09:44:52.900693 systemd[1]: Starting etcd-member.service...
Feb 9 09:44:52.936887 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Create new startup processor
Feb 9 09:44:52.939224 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [LongRunningPluginsManager] registered plugins: {}
Feb 9 09:44:52.939537 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Initializing bookkeeping folders
Feb 9 09:44:52.939673 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO removing the completed state files
Feb 9 09:44:52.939808 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Initializing bookkeeping folders for long running plugins
Feb 9 09:44:52.939941 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Initializing replies folder for MDS reply requests that couldn't reach the service
Feb 9 09:44:52.940071 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Initializing healthcheck folders for long running plugins
Feb 9 09:44:52.940201 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Initializing locations for inventory plugin
Feb 9 09:44:52.940397 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Initializing default location for custom inventory
Feb 9 09:44:52.941175 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Initializing default location for file inventory
Feb 9 09:44:52.941314 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Initializing default location for role inventory
Feb 9 09:44:52.941481 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Init the cloudwatchlogs publisher
Feb 9 09:44:52.942061 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Successfully loaded platform independent plugin aws:runDockerAction
Feb 9 09:44:52.942235 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Successfully loaded platform independent plugin aws:runDocument
Feb 9 09:44:52.942423 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Successfully loaded platform independent plugin aws:softwareInventory
Feb 9 09:44:52.942563 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Successfully loaded platform independent plugin aws:runPowerShellScript
Feb 9 09:44:52.942710 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Successfully loaded platform independent plugin aws:updateSsmAgent
Feb 9 09:44:52.942865 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Successfully loaded platform independent plugin aws:configureDocker
Feb 9 09:44:52.943035 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Successfully loaded platform independent plugin aws:refreshAssociation
Feb 9 09:44:52.943171 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Successfully loaded platform independent plugin aws:configurePackage
Feb 9 09:44:52.943316 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Successfully loaded platform independent plugin aws:downloadContent
Feb 9 09:44:52.943487 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Successfully loaded platform dependent plugin aws:runShellScript
Feb 9 09:44:52.943633 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO Starting Agent: amazon-ssm-agent - v2.3.1319.0
Feb 9 09:44:52.943787 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO OS: linux, Arch: arm64
Feb 9 09:44:52.951447 amazon-ssm-agent[1701]: datastore file /var/lib/amazon/ssm/i-018a51e043e012139/longrunningplugins/datastore/store doesn't exist - no long running plugins to execute
Feb 9 09:44:53.015312 systemd[1]: Starting docker.service...
Feb 9 09:44:53.039514 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessagingDeliveryService] Starting document processing engine...
Feb 9 09:44:53.116955 env[1903]: time="2024-02-09T09:44:53.116875206Z" level=info msg="Starting up"
Feb 9 09:44:53.120221 env[1903]: time="2024-02-09T09:44:53.120153665Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Feb 9 09:44:53.120221 env[1903]: time="2024-02-09T09:44:53.120203862Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Feb 9 09:44:53.120501 env[1903]: time="2024-02-09T09:44:53.120251316Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock <nil> 0 <nil>}] <nil> <nil>}" module=grpc
Feb 9 09:44:53.120501 env[1903]: time="2024-02-09T09:44:53.120276498Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Feb 9 09:44:53.123187 env[1903]: time="2024-02-09T09:44:53.123130012Z" level=info msg="parsed scheme: \"unix\"" module=grpc
Feb 9 09:44:53.123187 env[1903]: time="2024-02-09T09:44:53.123173708Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc
Feb 9 09:44:53.123411 env[1903]: time="2024-02-09T09:44:53.123207610Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock <nil> 0 <nil>}] <nil> <nil>}" module=grpc
Feb 9 09:44:53.123411 env[1903]: time="2024-02-09T09:44:53.123230609Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc
Feb 9 09:44:53.134229 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessagingDeliveryService] [EngineProcessor] Starting
Feb 9 09:44:53.178394 env[1903]: time="2024-02-09T09:44:53.178269790Z" level=info msg="Loading containers: start."
Feb 9 09:44:53.229023 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessagingDeliveryService] [EngineProcessor] Initial processing
Feb 9 09:44:53.279085 locksmithd[1765]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
Feb 9 09:44:53.323569 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessagingDeliveryService] Starting message polling
Feb 9 09:44:53.365377 kernel: Initializing XFRM netlink socket
Feb 9 09:44:53.410204 env[1903]: time="2024-02-09T09:44:53.410097461Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address"
Feb 9 09:44:53.412492 (udev-worker)[1558]: Network interface NamePolicy= disabled on kernel command line.
Feb 9 09:44:53.418325 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessagingDeliveryService] Starting send replies to MDS
Feb 9 09:44:53.508601 systemd-networkd[1535]: docker0: Link UP
Feb 9 09:44:53.513262 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [instanceID=i-018a51e043e012139] Starting association polling
Feb 9 09:44:53.530645 env[1903]: time="2024-02-09T09:44:53.530597796Z" level=info msg="Loading containers: done."
Feb 9 09:44:53.551367 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1213170290-merged.mount: Deactivated successfully.
Feb 9 09:44:53.565426 env[1903]: time="2024-02-09T09:44:53.565371906Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2
Feb 9 09:44:53.566074 env[1903]: time="2024-02-09T09:44:53.566043840Z" level=info msg="Docker daemon" commit=112bdf3343 graphdriver(s)=overlay2 version=20.10.23
Feb 9 09:44:53.566466 env[1903]: time="2024-02-09T09:44:53.566428680Z" level=info msg="Daemon has completed initialization"
Feb 9 09:44:53.606845 systemd[1]: Started docker.service.
Feb 9 09:44:53.609769 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessagingDeliveryService] [Association] [EngineProcessor] Starting
Feb 9 09:44:53.618369 env[1903]: time="2024-02-09T09:44:53.618265198Z" level=info msg="API listen on /run/docker.sock"
Feb 9 09:44:53.620122 etcd-wrapper[1896]: Error response from daemon: No such container: etcd-member
Feb 9 09:44:53.662424 etcd-wrapper[2016]: Error: No such container: etcd-member
Feb 9 09:44:53.703743 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessagingDeliveryService] [Association] Launching response handler
Feb 9 09:44:53.760595 etcd-wrapper[2033]: Unable to find image 'quay.io/coreos/etcd:v3.5.0-arm64' locally
Feb 9 09:44:53.799245 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessagingDeliveryService] [Association] [EngineProcessor] Initial processing
Feb 9 09:44:53.894982 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessagingDeliveryService] [Association] Initializing association scheduling service
Feb 9 09:44:53.990903 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessagingDeliveryService] [Association] Association scheduling service initialized
Feb 9 09:44:54.086959 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessageGatewayService] Starting session document processing engine...
Feb 9 09:44:54.183210 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessageGatewayService] [EngineProcessor] Starting
Feb 9 09:44:54.279797 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessageGatewayService] SSM Agent is trying to setup control channel for Session Manager module.
Feb 9 09:44:54.376361 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessageGatewayService] Setting up websocket for controlchannel for instance: i-018a51e043e012139, requestId: f5e1062f-4253-4d85-bfa7-b67149052930
Feb 9 09:44:54.473299 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [OfflineService] Starting document processing engine...
Feb 9 09:44:54.570383 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [OfflineService] [EngineProcessor] Starting
Feb 9 09:44:54.667648 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [OfflineService] [EngineProcessor] Initial processing
Feb 9 09:44:54.765064 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [OfflineService] Starting message polling
Feb 9 09:44:54.860235 sshd_keygen[1746]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
Feb 9 09:44:54.862838 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [OfflineService] Starting send replies to MDS
Feb 9 09:44:54.898519 systemd[1]: Finished sshd-keygen.service.
Feb 9 09:44:54.903277 systemd[1]: Starting issuegen.service...
Feb 9 09:44:54.914074 systemd[1]: issuegen.service: Deactivated successfully.
Feb 9 09:44:54.914452 systemd[1]: Finished issuegen.service.
Feb 9 09:44:54.919002 systemd[1]: Starting systemd-user-sessions.service...
Feb 9 09:44:54.933226 systemd[1]: Finished systemd-user-sessions.service.
Feb 9 09:44:54.938130 systemd[1]: Started getty@tty1.service.
Feb 9 09:44:54.942511 systemd[1]: Started serial-getty@ttyS0.service.
Feb 9 09:44:54.944777 systemd[1]: Reached target getty.target.
Feb 9 09:44:54.960641 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [LongRunningPluginsManager] starting long running plugin manager
Feb 9 09:44:55.058719 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [LongRunningPluginsManager] there aren't any long running plugin to execute
Feb 9 09:44:55.069858 etcd-wrapper[2033]: v3.5.0-arm64: Pulling from coreos/etcd
Feb 9 09:44:55.069858 etcd-wrapper[2033]: 6022c6b01d76: Pulling fs layer
Feb 9 09:44:55.069858 etcd-wrapper[2033]: 1d97b1ec77fc: Pulling fs layer
Feb 9 09:44:55.069858 etcd-wrapper[2033]: 99ef4b690837: Pulling fs layer
Feb 9 09:44:55.069858 etcd-wrapper[2033]: 435b7bf0967c: Pulling fs layer
Feb 9 09:44:55.069858 etcd-wrapper[2033]: 17e4a5f7c1b5: Pulling fs layer
Feb 9 09:44:55.069858 etcd-wrapper[2033]: 5b0292999756: Pulling fs layer
Feb 9 09:44:55.069858 etcd-wrapper[2033]: 435b7bf0967c: Waiting
Feb 9 09:44:55.071488 etcd-wrapper[2033]: 17e4a5f7c1b5: Waiting
Feb 9 09:44:55.071488 etcd-wrapper[2033]: 5b0292999756: Waiting
Feb 9 09:44:55.162264 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [HealthCheck] HealthCheck reporting agent health.
Feb 9 09:44:55.260792 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [LongRunningPluginsManager] There are no long running plugins currently getting executed - skipping their healthcheck
Feb 9 09:44:55.359424 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [MessageGatewayService] listening reply.
Feb 9 09:44:55.458363 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [StartupProcessor] Executing startup processor tasks
Feb 9 09:44:55.483923 etcd-wrapper[2033]: 99ef4b690837: Verifying Checksum
Feb 9 09:44:55.484380 etcd-wrapper[2033]: 99ef4b690837: Download complete
Feb 9 09:44:55.557369 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [StartupProcessor] Write to serial port: Amazon SSM Agent v2.3.1319.0 is running
Feb 9 09:44:55.656532 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [StartupProcessor] Write to serial port: OsProductName: Flatcar Container Linux by Kinvolk
Feb 9 09:44:55.711555 etcd-wrapper[2033]: 6022c6b01d76: Verifying Checksum
Feb 9 09:44:55.713376 etcd-wrapper[2033]: 6022c6b01d76: Download complete
Feb 9 09:44:55.722902 etcd-wrapper[2033]: 1d97b1ec77fc: Verifying Checksum
Feb 9 09:44:55.722902 etcd-wrapper[2033]: 1d97b1ec77fc: Download complete
Feb 9 09:44:55.756143 amazon-ssm-agent[1701]: 2024-02-09 09:44:52 INFO [StartupProcessor] Write to serial port: OsVersion: 3510.3.2
Feb 9 09:44:55.855710 amazon-ssm-agent[1701]: 2024-02-09 09:44:53 INFO [MessageGatewayService] Opening websocket connection to: wss://ssmmessages.us-west-2.amazonaws.com/v1/control-channel/i-018a51e043e012139?role=subscribe&stream=input
Feb 9 09:44:55.955598 amazon-ssm-agent[1701]: 2024-02-09 09:44:53 INFO [MessageGatewayService] Successfully opened websocket connection to: wss://ssmmessages.us-west-2.amazonaws.com/v1/control-channel/i-018a51e043e012139?role=subscribe&stream=input
Feb 9 09:44:56.048085 etcd-wrapper[2033]: 17e4a5f7c1b5: Verifying Checksum
Feb 9 09:44:56.048415 etcd-wrapper[2033]: 17e4a5f7c1b5: Download complete
Feb 9 09:44:56.055551 amazon-ssm-agent[1701]: 2024-02-09 09:44:53 INFO [MessageGatewayService] Starting receiving message from control channel
Feb 9 09:44:56.075754 etcd-wrapper[2033]: 5b0292999756: Verifying Checksum
Feb 9 09:44:56.076541 etcd-wrapper[2033]: 5b0292999756: Download complete
Feb 9 09:44:56.155828 amazon-ssm-agent[1701]: 2024-02-09 09:44:53 INFO [MessageGatewayService] [EngineProcessor] Initial processing
Feb 9 09:44:56.947086 etcd-wrapper[2033]: 435b7bf0967c: Verifying Checksum
Feb 9 09:44:56.947414 etcd-wrapper[2033]: 435b7bf0967c: Download complete
Feb 9 09:44:57.439471 etcd-wrapper[2033]: 6022c6b01d76: Pull complete
Feb 9 09:44:57.926594 systemd[1]: var-lib-docker-overlay2-4715e0ba23bdfd4ac85903406d007cdb04b19267c262492fd65b6e13707e58fb-merged.mount: Deactivated successfully.
Feb 9 09:44:58.503922 etcd-wrapper[2033]: 1d97b1ec77fc: Pull complete
Feb 9 09:44:58.882502 systemd[1]: var-lib-docker-overlay2-a08e5885cd46ac1a8f8d234724893b5fcb76dc785c3f4b703d75e450356a48cb-merged.mount: Deactivated successfully.
Feb 9 09:44:58.985605 etcd-wrapper[2033]: 99ef4b690837: Pull complete
Feb 9 09:44:59.340229 systemd[1]: var-lib-docker-overlay2-911d5839bf04797c3e7553c8be89be168a321962076d5e57ab6eb04a2d1b9e91-merged.mount: Deactivated successfully.
Feb 9 09:44:59.415269 etcd-wrapper[2033]: 435b7bf0967c: Pull complete
Feb 9 09:44:59.511129 systemd[1]: var-lib-docker-overlay2-0bfdc9940089147a71eaaba8acf553f1b186ce74918bf3c384da0ad8f63eaa50-merged.mount: Deactivated successfully.
Feb 9 09:44:59.512386 etcd-wrapper[2033]: 17e4a5f7c1b5: Pull complete
Feb 9 09:44:59.589706 systemd[1]: var-lib-docker-overlay2-ea760cb47398a08c83b3e8992e6b39b81f834f5476844f3110eee3ce11f8e7be-merged.mount: Deactivated successfully.
Feb 9 09:44:59.609706 etcd-wrapper[2033]: 5b0292999756: Pull complete
Feb 9 09:44:59.620173 etcd-wrapper[2033]: Digest: sha256:96255d1ad67e7afcea46b4dc1b7e74024b9f6971193cb7316b093b3b5671efb0
Feb 9 09:44:59.624244 etcd-wrapper[2033]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0-arm64
Feb 9 09:44:59.636215 systemd[1]: var-lib-docker-overlay2-063cfbbab927fee42cc2fca9db48227c46ca489355d48b557c96000bff2efda5\x2dinit-merged.mount: Deactivated successfully.
Feb 9 09:44:59.800137 env[1719]: time="2024-02-09T09:44:59.800010564Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Feb 9 09:44:59.801166 env[1719]: time="2024-02-09T09:44:59.800090463Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Feb 9 09:44:59.801166 env[1719]: time="2024-02-09T09:44:59.800117834Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Feb 9 09:44:59.801166 env[1719]: time="2024-02-09T09:44:59.800501053Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/4877a5b1a07fce56a6db2e3bb8da64607545d5a67c0cde7d8c27960af1059e1a pid=2105 runtime=io.containerd.runc.v2
Feb 9 09:44:59.822602 systemd[1]: Started docker-4877a5b1a07fce56a6db2e3bb8da64607545d5a67c0cde7d8c27960af1059e1a.scope.
Feb 9 09:44:59.927578 etcd-wrapper[2033]: {"level":"info","ts":1707471899.9271395,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"}
Feb 9 09:44:59.928007 etcd-wrapper[2033]: {"level":"info","ts":1707471899.9276292,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec2d7c527f3f1e3ada513676197c00ed"}
Feb 9 09:44:59.928007 etcd-wrapper[2033]: {"level":"warn","ts":1707471899.9277456,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"}
Feb 9 09:44:59.928007 etcd-wrapper[2033]: {"level":"warn","ts":1707471899.927796,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0-arm64"}
Feb 9 09:44:59.928007 etcd-wrapper[2033]: {"level":"warn","ts":1707471899.9278548,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"}
Feb 9 09:44:59.928378 etcd-wrapper[2033]: {"level":"warn","ts":1707471899.9280336,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"}
Feb 9 09:44:59.928378 etcd-wrapper[2033]: {"level":"warn","ts":1707471899.9282098,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"}
Feb 9 09:44:59.928748 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:44:59.928Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://172.31.25.229:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://172.31.25.229:2380","--advertise-client-urls=http://172.31.25.229:2379","--discovery=https://discovery.etcd.io/885b606fded4ee25c3c9bc3dcf0241e9"]}
Feb 9 09:44:59.929118 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:44:59.928Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://172.31.25.229:2380"]}
Feb 9 09:44:59.929651 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:44:59.929Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]}
Feb 9 09:44:59.930285 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:44:59.929Z","caller":"embed/etcd.go:307","msg":"starting an etcd server","etcd-version":"3.5.0","git-sha":"946a5a6f2","go-version":"go1.16.3","go-os":"linux","go-arch":"arm64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"ec2d7c527f3f1e3ada513676197c00ed","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://172.31.25.229:2380"],"listen-peer-urls":["http://172.31.25.229:2380"],"advertise-client-urls":["http://172.31.25.229:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec2d7c527f3f1e3ada513676197c00ed=http://172.31.25.229:2380","initial-cluster-state":"new","initial-cluster-token":"https://discovery.etcd.io/885b606fded4ee25c3c9bc3dcf0241e9","quota-size-bytes":2147483648,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"https://discovery.etcd.io/885b606fded4ee25c3c9bc3dcf0241e9","discovery-proxy":"","downgrade-check-interval":"5s"}
Feb 9 09:44:59.933403 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:44:59.933Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.306125ms"}
Feb 9 09:45:00.617710 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:00.617Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"https://discovery.etcd.io","self":"bf1c54e8102b8b6d"}
Feb 9 09:45:00.618419 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:00.617Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"https://discovery.etcd.io","found-peers":1,"needed-peers":2}
Feb 9 09:45:00.921869 systemd[1]: Created slice system-sshd.slice.
Feb 9 09:45:00.925066 systemd[1]: Started sshd@0-172.31.25.229:22-139.178.89.65:57976.service.
Feb 9 09:45:01.047950 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.047Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"e9cc9c516a61560b"}
Feb 9 09:45:01.047950 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.047Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"https://discovery.etcd.io","found-peers":2,"needed-peers":1}
Feb 9 09:45:01.113061 sshd[2143]: Accepted publickey for core from 139.178.89.65 port 57976 ssh2: RSA SHA256:1++YWC0h0fEpfkRPeemtMi9ARVJF0YKl/HjB0qv5R1M
Feb 9 09:45:01.117609 sshd[2143]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Feb 9 09:45:01.134219 systemd[1]: Created slice user-500.slice.
Feb 9 09:45:01.136905 systemd[1]: Starting user-runtime-dir@500.service...
Feb 9 09:45:01.140679 systemd-logind[1713]: New session 1 of user core.
Feb 9 09:45:01.164697 systemd[1]: Finished user-runtime-dir@500.service.
Feb 9 09:45:01.168755 systemd[1]: Starting user@500.service...
Feb 9 09:45:01.175771 (systemd)[2146]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
Feb 9 09:45:01.351658 systemd[2146]: Queued start job for default target default.target.
Feb 9 09:45:01.353162 systemd[2146]: Reached target paths.target.
Feb 9 09:45:01.353454 systemd[2146]: Reached target sockets.target.
Feb 9 09:45:01.353640 systemd[2146]: Reached target timers.target.
Feb 9 09:45:01.353874 systemd[2146]: Reached target basic.target.
Feb 9 09:45:01.354126 systemd[2146]: Reached target default.target.
Feb 9 09:45:01.354217 systemd[1]: Started user@500.service.
Feb 9 09:45:01.354452 systemd[2146]: Startup finished in 166ms.
Feb 9 09:45:01.357921 systemd[1]: Started session-1.scope.
Feb 9 09:45:01.511563 systemd[1]: Started sshd@1-172.31.25.229:22-139.178.89.65:57992.service.
Feb 9 09:45:01.686216 sshd[2155]: Accepted publickey for core from 139.178.89.65 port 57992 ssh2: RSA SHA256:1++YWC0h0fEpfkRPeemtMi9ARVJF0YKl/HjB0qv5R1M
Feb 9 09:45:01.689222 sshd[2155]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Feb 9 09:45:01.697543 systemd-logind[1713]: New session 2 of user core.
Feb 9 09:45:01.697991 systemd[1]: Started session-2.scope.
Feb 9 09:45:01.831779 sshd[2155]: pam_unix(sshd:session): session closed for user core
Feb 9 09:45:01.836660 systemd-logind[1713]: Session 2 logged out. Waiting for processes to exit.
Feb 9 09:45:01.837090 systemd[1]: sshd@1-172.31.25.229:22-139.178.89.65:57992.service: Deactivated successfully.
Feb 9 09:45:01.838449 systemd[1]: session-2.scope: Deactivated successfully.
Feb 9 09:45:01.839939 systemd-logind[1713]: Removed session 2.
Feb 9 09:45:01.859875 systemd[1]: Started sshd@2-172.31.25.229:22-139.178.89.65:58006.service.
Feb 9 09:45:01.917027 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.916Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"47fdbeab2a90f9eb"}
Feb 9 09:45:01.917027 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.916Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"https://discovery.etcd.io","found-peers":3}
Feb 9 09:45:01.922424 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.922Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"bf1c54e8102b8b6d","cluster-id":"1cc31d1e6c7c7070"}
Feb 9 09:45:01.922992 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d switched to configuration voters=()"}
Feb 9 09:45:01.922992 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d became follower at term 0"}
Feb 9 09:45:01.922992 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bf1c54e8102b8b6d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
Feb 9 09:45:01.922992 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d became follower at term 1"}
Feb 9 09:45:01.922992 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d switched to configuration voters=(5187511988163508715)"}
Feb 9 09:45:01.922992 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d switched to configuration voters=(5187511988163508715 13770975116272569197)"}
Feb 9 09:45:01.922992 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d switched to configuration voters=(5187511988163508715 13770975116272569197 16847012179577230859)"}
Feb 9 09:45:01.924727 etcd-wrapper[2033]: {"level":"warn","ts":"2024-02-09T09:45:01.924Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"}
Feb 9 09:45:01.926660 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.926Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1}
Feb 9 09:45:01.928747 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.928Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
Feb 9 09:45:01.930197 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.929Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:01.930197 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.929Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:01.934198 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.933Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:01.935179 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.934Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:01.936740 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.936Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:01.937195 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.936Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:01.937195 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.936Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb","remote-peer-urls":["http://172.31.20.77:2380"]}
Feb 9 09:45:01.937195 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.936Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.937195 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.936Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.939192 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.936Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:01.941571 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.941Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.942763 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.941Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.943561 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.943Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"e9cc9c516a61560b","remote-peer-urls":["http://172.31.23.249:2380"]}
Feb 9 09:45:01.944460 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.943Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.944460 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.944Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.944945 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.944Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.945521 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.945Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"bf1c54e8102b8b6d","local-server-version":"3.5.0","cluster-version":"to_be_decided"}
Feb 9 09:45:01.946531 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.946Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10}
Feb 9 09:45:01.947778 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d switched to configuration voters=(5187511988163508715 13770975116272569197 16847012179577230859)"}
Feb 9 09:45:01.948495 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.948Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"1cc31d1e6c7c7070","local-member-id":"bf1c54e8102b8b6d","added-peer-id":"47fdbeab2a90f9eb","added-peer-peer-urls":["http://172.31.20.77:2380"]}
Feb 9 09:45:01.949040 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d switched to configuration voters=(5187511988163508715 13770975116272569197 16847012179577230859)"}
Feb 9 09:45:01.949599 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.949Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"1cc31d1e6c7c7070","local-member-id":"bf1c54e8102b8b6d","added-peer-id":"bf1c54e8102b8b6d","added-peer-peer-urls":["http://172.31.25.229:2380"]}
Feb 9 09:45:01.950379 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d switched to configuration voters=(5187511988163508715 13770975116272569197 16847012179577230859)"}
Feb 9 09:45:01.951000 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.950Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"1cc31d1e6c7c7070","local-member-id":"bf1c54e8102b8b6d","added-peer-id":"e9cc9c516a61560b","added-peer-peer-urls":["http://172.31.23.249:2380"]}
Feb 9 09:45:01.955698 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.955Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"172.31.25.229:2380"}
Feb 9 09:45:01.955698 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.955Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"172.31.25.229:2380"}
Feb 9 09:45:01.956456 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.955Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"bf1c54e8102b8b6d","to":"e9cc9c516a61560b","stream-type":"stream Message"}
Feb 9 09:45:01.956456 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.955Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.956456 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.955Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.957126 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.956Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"bf1c54e8102b8b6d","to":"e9cc9c516a61560b","stream-type":"stream MsgApp v2"}
Feb 9 09:45:01.957126 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.956Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.957126 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.955Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"bf1c54e8102b8b6d","initial-advertise-peer-urls":["http://172.31.25.229:2380"],"listen-peer-urls":["http://172.31.25.229:2380"],"advertise-client-urls":["http://172.31.25.229:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]}
Feb 9 09:45:01.957126 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.956Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:01.957126 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:01.956Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"e9cc9c516a61560b"}
Feb 9 09:45:02.033406 sshd[2161]: Accepted publickey for core from 139.178.89.65 port 58006 ssh2: RSA SHA256:1++YWC0h0fEpfkRPeemtMi9ARVJF0YKl/HjB0qv5R1M
Feb 9 09:45:02.035750 sshd[2161]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Feb 9 09:45:02.044307 systemd[1]: Started session-3.scope.
Feb 9 09:45:02.045037 systemd-logind[1713]: New session 3 of user core.
Feb 9 09:45:02.105005 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.102Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"bf1c54e8102b8b6d","to":"47fdbeab2a90f9eb","stream-type":"stream MsgApp v2"}
Feb 9 09:45:02.105005 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.103Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:02.105005 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.103Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:02.105005 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.104Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"bf1c54e8102b8b6d","to":"47fdbeab2a90f9eb","stream-type":"stream Message"}
Feb 9 09:45:02.105005 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.104Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:02.118219 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.117Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:02.119281 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.118Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:02.150043 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.149Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"bf1c54e8102b8b6d","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2}
Feb 9 09:45:02.173608 sshd[2161]: pam_unix(sshd:session): session closed for user core
Feb 9 09:45:02.178730 systemd-logind[1713]: Session 3 logged out. Waiting for processes to exit.
Feb 9 09:45:02.179318 systemd[1]: sshd@2-172.31.25.229:22-139.178.89.65:58006.service: Deactivated successfully.
Feb 9 09:45:02.180532 systemd[1]: session-3.scope: Deactivated successfully.
Feb 9 09:45:02.182179 systemd-logind[1713]: Removed session 3.
Feb 9 09:45:02.226748 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d [logterm: 1, index: 3, vote: 0] cast MsgPreVote for e9cc9c516a61560b [logterm: 1, index: 3] at term 1"}
Feb 9 09:45:02.229618 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d [term: 1] received a MsgVote message with higher term from e9cc9c516a61560b [term: 2]"}
Feb 9 09:45:02.230004 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d became follower at term 2"}
Feb 9 09:45:02.230377 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.230Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf1c54e8102b8b6d [logterm: 1, index: 3, vote: 0] cast MsgVote for e9cc9c516a61560b [logterm: 1, index: 3] at term 2"}
Feb 9 09:45:02.232554 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bf1c54e8102b8b6d elected leader e9cc9c516a61560b at term 2"}
Feb 9 09:45:02.237706 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.237Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"bf1c54e8102b8b6d","local-member-attributes":"{Name:ec2d7c527f3f1e3ada513676197c00ed ClientURLs:[http://172.31.25.229:2379]}","request-path":"/0/members/bf1c54e8102b8b6d/attributes","cluster-id":"1cc31d1e6c7c7070","publish-timeout":"7s"}
Feb 9 09:45:02.238096 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.237Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"}
Feb 9 09:45:02.238829 systemd[1]: Started etcd-member.service.
Feb 9 09:45:02.239416 systemd[1]: Reached target multi-user.target.
Feb 9 09:45:02.241606 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.238Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"}
Feb 9 09:45:02.242031 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.238Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"}
Feb 9 09:45:02.242116 systemd[1]: Starting systemd-update-utmp-runlevel.service...
Feb 9 09:45:02.250379 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.249Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"}
Feb 9 09:45:02.251592 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.251Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"1cc31d1e6c7c7070","local-member-id":"bf1c54e8102b8b6d","cluster-version":"3.5"}
Feb 9 09:45:02.252819 etcd-wrapper[2033]: {"level":"info","ts":"2024-02-09T09:45:02.252Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
Feb 9 09:45:02.257788 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully.
Feb 9 09:45:02.258191 systemd[1]: Finished systemd-update-utmp-runlevel.service.
Feb 9 09:45:02.258569 systemd[1]: Startup finished in 1.135s (kernel) + 6.822s (initrd) + 18.843s (userspace) = 26.801s.
Feb 9 09:45:12.191189 systemd[1]: Started sshd@3-172.31.25.229:22-139.178.89.65:36870.service.
Feb 9 09:45:12.364750 sshd[2173]: Accepted publickey for core from 139.178.89.65 port 36870 ssh2: RSA SHA256:1++YWC0h0fEpfkRPeemtMi9ARVJF0YKl/HjB0qv5R1M
Feb 9 09:45:12.367961 sshd[2173]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Feb 9 09:45:12.376478 systemd-logind[1713]: New session 4 of user core.
Feb 9 09:45:12.376769 systemd[1]: Started session-4.scope.
Feb 9 09:45:12.481202 amazon-ssm-agent[1701]: 2024-02-09 09:45:12 INFO [MessagingDeliveryService] [Association] No associations on boot. Requerying for associations after 30 seconds.
Feb 9 09:45:12.507481 sshd[2173]: pam_unix(sshd:session): session closed for user core
Feb 9 09:45:12.512613 systemd-logind[1713]: Session 4 logged out. Waiting for processes to exit.
Feb 9 09:45:12.513202 systemd[1]: sshd@3-172.31.25.229:22-139.178.89.65:36870.service: Deactivated successfully.
Feb 9 09:45:12.514462 systemd[1]: session-4.scope: Deactivated successfully.
Feb 9 09:45:12.516224 systemd-logind[1713]: Removed session 4.
Feb 9 09:45:12.535657 systemd[1]: Started sshd@4-172.31.25.229:22-139.178.89.65:36872.service.
Feb 9 09:45:12.710885 sshd[2179]: Accepted publickey for core from 139.178.89.65 port 36872 ssh2: RSA SHA256:1++YWC0h0fEpfkRPeemtMi9ARVJF0YKl/HjB0qv5R1M
Feb 9 09:45:12.713800 sshd[2179]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Feb 9 09:45:12.722280 systemd[1]: Started session-5.scope.
Feb 9 09:45:12.723321 systemd-logind[1713]: New session 5 of user core.
Feb 9 09:45:12.843943 sshd[2179]: pam_unix(sshd:session): session closed for user core
Feb 9 09:45:12.849944 systemd[1]: session-5.scope: Deactivated successfully.
Feb 9 09:45:12.852180 systemd-logind[1713]: Session 5 logged out. Waiting for processes to exit.
Feb 9 09:45:12.853043 systemd[1]: sshd@4-172.31.25.229:22-139.178.89.65:36872.service: Deactivated successfully.
Feb 9 09:45:12.856023 systemd-logind[1713]: Removed session 5.
Feb 9 09:45:12.873294 systemd[1]: Started sshd@5-172.31.25.229:22-139.178.89.65:36878.service.
Feb 9 09:45:13.050385 sshd[2185]: Accepted publickey for core from 139.178.89.65 port 36878 ssh2: RSA SHA256:1++YWC0h0fEpfkRPeemtMi9ARVJF0YKl/HjB0qv5R1M
Feb 9 09:45:13.053235 sshd[2185]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Feb 9 09:45:13.061424 systemd[1]: Started session-6.scope.
Feb 9 09:45:13.062654 systemd-logind[1713]: New session 6 of user core.
Feb 9 09:45:13.193720 sshd[2185]: pam_unix(sshd:session): session closed for user core
Feb 9 09:45:13.199140 systemd[1]: sshd@5-172.31.25.229:22-139.178.89.65:36878.service: Deactivated successfully.
Feb 9 09:45:13.200448 systemd[1]: session-6.scope: Deactivated successfully.
Feb 9 09:45:13.201577 systemd-logind[1713]: Session 6 logged out. Waiting for processes to exit.
Feb 9 09:45:13.203111 systemd-logind[1713]: Removed session 6.
Feb 9 09:45:13.220021 systemd[1]: Started sshd@6-172.31.25.229:22-139.178.89.65:36880.service.
Feb 9 09:45:13.390016 sshd[2191]: Accepted publickey for core from 139.178.89.65 port 36880 ssh2: RSA SHA256:1++YWC0h0fEpfkRPeemtMi9ARVJF0YKl/HjB0qv5R1M
Feb 9 09:45:13.393085 sshd[2191]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Feb 9 09:45:13.401669 systemd[1]: Started session-7.scope.
Feb 9 09:45:13.402683 systemd-logind[1713]: New session 7 of user core.
Feb 9 09:45:13.522150 sudo[2194]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1
Feb 9 09:45:13.523451 sudo[2194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Feb 9 09:45:13.537689 dbus-daemon[1705]: avc: received setenforce notice (enforcing=1)
Feb 9 09:45:13.540589 sudo[2194]: pam_unix(sudo:session): session closed for user root
Feb 9 09:45:13.564499 sshd[2191]: pam_unix(sshd:session): session closed for user core
Feb 9 09:45:13.569969 systemd[1]: session-7.scope: Deactivated successfully.
Feb 9 09:45:13.571230 systemd[1]: sshd@6-172.31.25.229:22-139.178.89.65:36880.service: Deactivated successfully.
Feb 9 09:45:13.573199 systemd-logind[1713]: Session 7 logged out. Waiting for processes to exit.
Feb 9 09:45:13.575500 systemd-logind[1713]: Removed session 7.
Feb 9 09:45:13.593484 systemd[1]: Started sshd@7-172.31.25.229:22-139.178.89.65:36884.service.
Feb 9 09:45:13.770643 sshd[2198]: Accepted publickey for core from 139.178.89.65 port 36884 ssh2: RSA SHA256:1++YWC0h0fEpfkRPeemtMi9ARVJF0YKl/HjB0qv5R1M
Feb 9 09:45:13.773905 sshd[2198]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Feb 9 09:45:13.782469 systemd-logind[1713]: New session 8 of user core.
Feb 9 09:45:13.784203 systemd[1]: Started session-8.scope.
Feb 9 09:45:13.892834 sudo[2202]: 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
Feb 9 09:45:13.894003 sudo[2202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Feb 9 09:45:13.899950 sudo[2202]: pam_unix(sudo:session): session closed for user root
Feb 9 09:45:13.909476 sudo[2201]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules
Feb 9 09:45:13.909996 sudo[2201]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Feb 9 09:45:13.927138 systemd[1]: Stopping audit-rules.service...
Feb 9 09:45:13.928000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1
Feb 9 09:45:13.931894 kernel: kauditd_printk_skb: 72 callbacks suppressed
Feb 9 09:45:13.931976 kernel: audit: type=1305 audit(1707471913.928:164): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1
Feb 9 09:45:13.928000 audit[2205]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffcf58b7b0 a2=420 a3=0 items=0 ppid=1 pid=2205 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)
Feb 9 09:45:13.938403 auditctl[2205]: No rules
Feb 9 09:45:13.939162 systemd[1]: audit-rules.service: Deactivated successfully.
Feb 9 09:45:13.939582 systemd[1]: Stopped audit-rules.service.
Feb 9 09:45:13.942804 systemd[1]: Starting audit-rules.service...
Feb 9 09:45:13.956013 kernel: audit: type=1300 audit(1707471913.928:164): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffcf58b7b0 a2=420 a3=0 items=0 ppid=1 pid=2205 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)
Feb 9 09:45:13.956125 kernel: audit: type=1327 audit(1707471913.928:164): proctitle=2F7362696E2F617564697463746C002D44
Feb 9 09:45:13.928000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44
Feb 9 09:45:13.937000 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'
Feb 9 09:45:13.965400 kernel: audit: type=1131 audit(1707471913.937:165): 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'
Feb 9 09:45:13.984632 augenrules[2222]: No rules
Feb 9 09:45:13.986476 systemd[1]: Finished audit-rules.service.
Feb 9 09:45:13.985000 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'
Feb 9 09:45:13.995854 sudo[2201]: pam_unix(sudo:session): session closed for user root
Feb 9 09:45:13.995000 audit[2201]: USER_END pid=2201 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Feb 9 09:45:14.005473 kernel: audit: type=1130 audit(1707471913.985:166): 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'
Feb 9 09:45:14.005576 kernel: audit: type=1106 audit(1707471913.995:167): pid=2201 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Feb 9 09:45:13.995000 audit[2201]: CRED_DISP pid=2201 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Feb 9 09:45:14.014333 kernel: audit: type=1104 audit(1707471913.995:168): pid=2201 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Feb 9 09:45:14.029647 sshd[2198]: pam_unix(sshd:session): session closed for user core
Feb 9 09:45:14.030000 audit[2198]: USER_END pid=2198 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Feb 9 09:45:14.035188 systemd[1]: session-8.scope: Deactivated successfully.
Feb 9 09:45:14.036828 systemd[1]: sshd@7-172.31.25.229:22-139.178.89.65:36884.service: Deactivated successfully.
Feb 9 09:45:14.030000 audit[2198]: CRED_DISP pid=2198 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Feb 9 09:45:14.044473 kernel: audit: type=1106 audit(1707471914.030:169): pid=2198 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Feb 9 09:45:14.045104 systemd-logind[1713]: Session 8 logged out. Waiting for processes to exit.
Feb 9 09:45:14.047401 systemd-logind[1713]: Removed session 8.
Feb 9 09:45:14.035000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-172.31.25.229:22-139.178.89.65:36884 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:45:14.054508 kernel: audit: type=1104 audit(1707471914.030:170): pid=2198 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Feb 9 09:45:14.064415 kernel: audit: type=1131 audit(1707471914.035:171): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-172.31.25.229:22-139.178.89.65:36884 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:45:18.208714 etcd-wrapper[2033]: {"level":"warn","ts":"2024-02-09T09:45:18.208Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb","error":"EOF"}
Feb 9 09:45:18.209373 etcd-wrapper[2033]: {"level":"warn","ts":"2024-02-09T09:45:18.208Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb","error":"EOF"}
Feb 9 09:45:18.217245 etcd-wrapper[2033]: {"level":"warn","ts":"2024-02-09T09:45:18.216Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"47fdbeab2a90f9eb","error":"failed to dial 47fdbeab2a90f9eb on stream Message (peer 47fdbeab2a90f9eb failed to find local node bf1c54e8102b8b6d)"}
Feb 9 09:45:22.773261 systemd[1]: systemd-hostnamed.service: Deactivated successfully.
Feb 9 09:45:22.772000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:45:22.782393 kernel: audit: type=1131 audit(1707471922.772:172): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Feb 9 09:45:22.804000 audit: BPF prog-id=34 op=UNLOAD
Feb 9 09:45:22.804000 audit: BPF prog-id=33 op=UNLOAD
Feb 9 09:45:22.810731 kernel: audit: type=1334 audit(1707471922.804:173): prog-id=34 op=UNLOAD
Feb 9 09:45:22.810811 kernel: audit: type=1334 audit(1707471922.804:174): prog-id=33 op=UNLOAD
Feb 9 09:45:22.810871 kernel: audit: type=1334 audit(1707471922.804:175): prog-id=32 op=UNLOAD
Feb 9 09:45:22.804000 audit: BPF prog-id=32 op=UNLOAD
Feb 9 09:45:23.601868 etcd-wrapper[2033]: {"level":"warn","ts":"2024-02-09T09:45:23.601Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:23.602843 etcd-wrapper[2033]: {"level":"warn","ts":"2024-02-09T09:45:23.602Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"bf1c54e8102b8b6d","remote-peer-id":"47fdbeab2a90f9eb"}
Feb 9 09:45:36.942082 etcd-wrapper[2033]: {"level":"warn","ts":"2024-02-09T09:45:36.941Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"47fdbeab2a90f9eb","rtt":"396.71µs","error":"dial tcp 172.31.20.77:2380: i/o timeout"}
Feb 9 09:45:36.942872 etcd-wrapper[2033]: {"level":"warn","ts":"2024-02-09T09:45:36.941Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"47fdbeab2a90f9eb","rtt":"546.556µs","error":"dial tcp 172.31.20.77:2380: i/o timeout"}
Feb 9 09:45:37.471188 update_engine[1714]: I0209 09:45:37.471115 1714 update_attempter.cc:509] Updating boot flags...