Oct 2 18:47:49.202797 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083]
Oct 2 18:47:49.202836 kernel: Linux version 5.15.132-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 Mon Oct 2 17:55:37 -00 2023
Oct 2 18:47:49.202859 kernel: efi: EFI v2.70 by EDK II
Oct 2 18:47:49.202874 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7ac1aa98 MEMRESERVE=0x71accf98
Oct 2 18:47:49.202888 kernel: ACPI: Early table checksum verification disabled
Oct 2 18:47:49.202902 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON)
Oct 2 18:47:49.202917 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013)
Oct 2 18:47:49.202932 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001)
Oct 2 18:47:49.202946 kernel: ACPI: DSDT 0x0000000078640000 00154F (v02 AMAZON AMZNDSDT 00000001 INTL 20160527)
Oct 2 18:47:49.202960 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001)
Oct 2 18:47:49.202978 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001)
Oct 2 18:47:49.202992 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001)
Oct 2 18:47:49.203005 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001)
Oct 2 18:47:49.203020 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001)
Oct 2 18:47:49.203036 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001)
Oct 2 18:47:49.203054 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001)
Oct 2 18:47:49.203069 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200
Oct 2 18:47:49.203083 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200')
Oct 2 18:47:49.203097 kernel: printk: bootconsole [uart0] enabled
Oct 2 18:47:49.203112 kernel: NUMA: Failed to initialise from firmware
Oct 2 18:47:49.203127 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff]
Oct 2 18:47:49.203141 kernel: NUMA: NODE_DATA [mem 0x4b5841900-0x4b5846fff]
Oct 2 18:47:49.203156 kernel: Zone ranges:
Oct 2 18:47:49.203170 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff]
Oct 2 18:47:49.203185 kernel: DMA32 empty
Oct 2 18:47:49.203199 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff]
Oct 2 18:47:49.203217 kernel: Movable zone start for each node
Oct 2 18:47:49.203232 kernel: Early memory node ranges
Oct 2 18:47:49.203246 kernel: node 0: [mem 0x0000000040000000-0x00000000786effff]
Oct 2 18:47:49.203261 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff]
Oct 2 18:47:49.203275 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff]
Oct 2 18:47:49.203290 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff]
Oct 2 18:47:49.203305 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff]
Oct 2 18:47:49.203320 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff]
Oct 2 18:47:49.203335 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff]
Oct 2 18:47:49.203350 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges
Oct 2 18:47:49.203364 kernel: psci: probing for conduit method from ACPI.
Oct 2 18:47:49.203378 kernel: psci: PSCIv1.0 detected in firmware.
Oct 2 18:47:49.203397 kernel: psci: Using standard PSCI v0.2 function IDs
Oct 2 18:47:49.203412 kernel: psci: Trusted OS migration not required
Oct 2 18:47:49.203432 kernel: psci: SMC Calling Convention v1.1
Oct 2 18:47:49.203448 kernel: ACPI: SRAT not present
Oct 2 18:47:49.203510 kernel: percpu: Embedded 29 pages/cpu s79960 r8192 d30632 u118784
Oct 2 18:47:49.203533 kernel: pcpu-alloc: s79960 r8192 d30632 u118784 alloc=29*4096
Oct 2 18:47:49.203549 kernel: pcpu-alloc: [0] 0 [0] 1
Oct 2 18:47:49.203565 kernel: Detected PIPT I-cache on CPU0
Oct 2 18:47:49.203580 kernel: CPU features: detected: GIC system register CPU interface
Oct 2 18:47:49.203596 kernel: CPU features: detected: Spectre-v2
Oct 2 18:47:49.203611 kernel: CPU features: detected: Spectre-v3a
Oct 2 18:47:49.203626 kernel: CPU features: detected: Spectre-BHB
Oct 2 18:47:49.203641 kernel: CPU features: kernel page table isolation forced ON by KASLR
Oct 2 18:47:49.203656 kernel: CPU features: detected: Kernel page table isolation (KPTI)
Oct 2 18:47:49.203672 kernel: CPU features: detected: ARM erratum 1742098
Oct 2 18:47:49.203687 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923
Oct 2 18:47:49.203705 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872
Oct 2 18:47:49.203721 kernel: Policy zone: Normal
Oct 2 18:47:49.203739 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=684fe6a2259d7fb96810743ab87aaaa03d9f185b113bd6990a64d1079e5672ca
Oct 2 18:47:49.203755 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
Oct 2 18:47:49.203771 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
Oct 2 18:47:49.203786 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
Oct 2 18:47:49.203801 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Oct 2 18:47:49.203816 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB)
Oct 2 18:47:49.203833 kernel: Memory: 3826444K/4030464K available (9792K kernel code, 2092K rwdata, 7548K rodata, 34560K init, 779K bss, 204020K reserved, 0K cma-reserved)
Oct 2 18:47:49.203849 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
Oct 2 18:47:49.203869 kernel: trace event string verifier disabled
Oct 2 18:47:49.203885 kernel: rcu: Preemptible hierarchical RCU implementation.
Oct 2 18:47:49.203901 kernel: rcu: RCU event tracing is enabled.
Oct 2 18:47:49.203917 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
Oct 2 18:47:49.203932 kernel: Trampoline variant of Tasks RCU enabled.
Oct 2 18:47:49.203948 kernel: Tracing variant of Tasks RCU enabled.
Oct 2 18:47:49.203963 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
Oct 2 18:47:49.203979 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
Oct 2 18:47:49.203994 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
Oct 2 18:47:49.204010 kernel: GICv3: 96 SPIs implemented
Oct 2 18:47:49.204025 kernel: GICv3: 0 Extended SPIs implemented
Oct 2 18:47:49.204040 kernel: GICv3: Distributor has no Range Selector support
Oct 2 18:47:49.204059 kernel: Root IRQ handler: gic_handle_irq
Oct 2 18:47:49.204074 kernel: GICv3: 16 PPIs implemented
Oct 2 18:47:49.204090 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000
Oct 2 18:47:49.204105 kernel: ACPI: SRAT not present
Oct 2 18:47:49.204120 kernel: ITS [mem 0x10080000-0x1009ffff]
Oct 2 18:47:49.204136 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000a0000 (indirect, esz 8, psz 64K, shr 1)
Oct 2 18:47:49.204151 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000b0000 (flat, esz 8, psz 64K, shr 1)
Oct 2 18:47:49.204166 kernel: GICv3: using LPI property table @0x00000004000c0000
Oct 2 18:47:49.204181 kernel: ITS: Using hypervisor restricted LPI range [128]
Oct 2 18:47:49.204197 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000d0000
Oct 2 18:47:49.204212 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt).
Oct 2 18:47:49.204233 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns
Oct 2 18:47:49.204249 kernel: sched_clock: 56 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns
Oct 2 18:47:49.204264 kernel: Console: colour dummy device 80x25
Oct 2 18:47:49.204280 kernel: printk: console [tty1] enabled
Oct 2 18:47:49.204295 kernel: ACPI: Core revision 20210730
Oct 2 18:47:49.204311 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333)
Oct 2 18:47:49.204327 kernel: pid_max: default: 32768 minimum: 301
Oct 2 18:47:49.204343 kernel: LSM: Security Framework initializing
Oct 2 18:47:49.204359 kernel: SELinux: Initializing.
Oct 2 18:47:49.204375 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Oct 2 18:47:49.204396 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Oct 2 18:47:49.204412 kernel: rcu: Hierarchical SRCU implementation.
Oct 2 18:47:49.204428 kernel: Platform MSI: ITS@0x10080000 domain created
Oct 2 18:47:49.204443 kernel: PCI/MSI: ITS@0x10080000 domain created
Oct 2 18:47:49.204487 kernel: Remapping and enabling EFI services.
Oct 2 18:47:49.204508 kernel: smp: Bringing up secondary CPUs ...
Oct 2 18:47:49.204525 kernel: Detected PIPT I-cache on CPU1
Oct 2 18:47:49.204541 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000
Oct 2 18:47:49.204557 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000e0000
Oct 2 18:47:49.204579 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083]
Oct 2 18:47:49.204595 kernel: smp: Brought up 1 node, 2 CPUs
Oct 2 18:47:49.204610 kernel: SMP: Total of 2 processors activated.
Oct 2 18:47:49.204626 kernel: CPU features: detected: 32-bit EL0 Support
Oct 2 18:47:49.204642 kernel: CPU features: detected: 32-bit EL1 Support
Oct 2 18:47:49.204657 kernel: CPU features: detected: CRC32 instructions
Oct 2 18:47:49.204673 kernel: CPU: All CPU(s) started at EL1
Oct 2 18:47:49.204688 kernel: alternatives: patching kernel code
Oct 2 18:47:49.204703 kernel: devtmpfs: initialized
Oct 2 18:47:49.204722 kernel: KASLR disabled due to lack of seed
Oct 2 18:47:49.204738 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
Oct 2 18:47:49.204754 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear)
Oct 2 18:47:49.204780 kernel: pinctrl core: initialized pinctrl subsystem
Oct 2 18:47:49.204800 kernel: SMBIOS 3.0.0 present.
Oct 2 18:47:49.204816 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018
Oct 2 18:47:49.204832 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Oct 2 18:47:49.204848 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
Oct 2 18:47:49.204864 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
Oct 2 18:47:49.204881 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
Oct 2 18:47:49.204906 kernel: audit: initializing netlink subsys (disabled)
Oct 2 18:47:49.204925 kernel: audit: type=2000 audit(0.250:1): state=initialized audit_enabled=0 res=1
Oct 2 18:47:49.204947 kernel: thermal_sys: Registered thermal governor 'step_wise'
Oct 2 18:47:49.204963 kernel: cpuidle: using governor menu
Oct 2 18:47:49.204979 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
Oct 2 18:47:49.204996 kernel: ASID allocator initialised with 32768 entries
Oct 2 18:47:49.205012 kernel: ACPI: bus type PCI registered
Oct 2 18:47:49.205049 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Oct 2 18:47:49.205071 kernel: Serial: AMBA PL011 UART driver
Oct 2 18:47:49.205087 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
Oct 2 18:47:49.205103 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
Oct 2 18:47:49.205119 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
Oct 2 18:47:49.205136 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
Oct 2 18:47:49.205152 kernel: cryptd: max_cpu_qlen set to 1000
Oct 2 18:47:49.205168 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng)
Oct 2 18:47:49.205184 kernel: ACPI: Added _OSI(Module Device)
Oct 2 18:47:49.205206 kernel: ACPI: Added _OSI(Processor Device)
Oct 2 18:47:49.205222 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Oct 2 18:47:49.205238 kernel: ACPI: Added _OSI(Processor Aggregator Device)
Oct 2 18:47:49.205254 kernel: ACPI: Added _OSI(Linux-Dell-Video)
Oct 2 18:47:49.205270 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
Oct 2 18:47:49.205286 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
Oct 2 18:47:49.205302 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
Oct 2 18:47:49.205318 kernel: ACPI: Interpreter enabled
Oct 2 18:47:49.205334 kernel: ACPI: Using GIC for interrupt routing
Oct 2 18:47:49.205354 kernel: ACPI: MCFG table detected, 1 entries
Oct 2 18:47:49.205371 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f])
Oct 2 18:47:49.205824 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
Oct 2 18:47:49.206027 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR]
Oct 2 18:47:49.206224 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]
Oct 2 18:47:49.206417 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00
Oct 2 18:47:49.210770 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f]
Oct 2 18:47:49.210821 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window]
Oct 2 18:47:49.210840 kernel: acpiphp: Slot [1] registered
Oct 2 18:47:49.210858 kernel: acpiphp: Slot [2] registered
Oct 2 18:47:49.210874 kernel: acpiphp: Slot [3] registered
Oct 2 18:47:49.210891 kernel: acpiphp: Slot [4] registered
Oct 2 18:47:49.210907 kernel: acpiphp: Slot [5] registered
Oct 2 18:47:49.210923 kernel: acpiphp: Slot [6] registered
Oct 2 18:47:49.210939 kernel: acpiphp: Slot [7] registered
Oct 2 18:47:49.210956 kernel: acpiphp: Slot [8] registered
Oct 2 18:47:49.210976 kernel: acpiphp: Slot [9] registered
Oct 2 18:47:49.210992 kernel: acpiphp: Slot [10] registered
Oct 2 18:47:49.211008 kernel: acpiphp: Slot [11] registered
Oct 2 18:47:49.211024 kernel: acpiphp: Slot [12] registered
Oct 2 18:47:49.211040 kernel: acpiphp: Slot [13] registered
Oct 2 18:47:49.211056 kernel: acpiphp: Slot [14] registered
Oct 2 18:47:49.211073 kernel: acpiphp: Slot [15] registered
Oct 2 18:47:49.211089 kernel: acpiphp: Slot [16] registered
Oct 2 18:47:49.211105 kernel: acpiphp: Slot [17] registered
Oct 2 18:47:49.211121 kernel: acpiphp: Slot [18] registered
Oct 2 18:47:49.211141 kernel: acpiphp: Slot [19] registered
Oct 2 18:47:49.211157 kernel: acpiphp: Slot [20] registered
Oct 2 18:47:49.211173 kernel: acpiphp: Slot [21] registered
Oct 2 18:47:49.211189 kernel: acpiphp: Slot [22] registered
Oct 2 18:47:49.211205 kernel: acpiphp: Slot [23] registered
Oct 2 18:47:49.211221 kernel: acpiphp: Slot [24] registered
Oct 2 18:47:49.211237 kernel: acpiphp: Slot [25] registered
Oct 2 18:47:49.211253 kernel: acpiphp: Slot [26] registered
Oct 2 18:47:49.211269 kernel: acpiphp: Slot [27] registered
Oct 2 18:47:49.211289 kernel: acpiphp: Slot [28] registered
Oct 2 18:47:49.211305 kernel: acpiphp: Slot [29] registered
Oct 2 18:47:49.211321 kernel: acpiphp: Slot [30] registered
Oct 2 18:47:49.211337 kernel: acpiphp: Slot [31] registered
Oct 2 18:47:49.211353 kernel: PCI host bridge to bus 0000:00
Oct 2 18:47:49.211602 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window]
Oct 2 18:47:49.211781 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]
Oct 2 18:47:49.211957 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window]
Oct 2 18:47:49.212135 kernel: pci_bus 0000:00: root bus resource [bus 00-0f]
Oct 2 18:47:49.212350 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000
Oct 2 18:47:49.212590 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003
Oct 2 18:47:49.212788 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff]
Oct 2 18:47:49.213004 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802
Oct 2 18:47:49.213226 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff]
Oct 2 18:47:49.225503 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold
Oct 2 18:47:49.225743 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000
Oct 2 18:47:49.225941 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff]
Oct 2 18:47:49.226134 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref]
Oct 2 18:47:49.226326 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff]
Oct 2 18:47:49.226565 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold
Oct 2 18:47:49.226769 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref]
Oct 2 18:47:49.226973 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff]
Oct 2 18:47:49.227171 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff]
Oct 2 18:47:49.227383 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff]
Oct 2 18:47:49.227618 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff]
Oct 2 18:47:49.227809 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window]
Oct 2 18:47:49.227990 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]
Oct 2 18:47:49.228172 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window]
Oct 2 18:47:49.228202 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35
Oct 2 18:47:49.228221 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36
Oct 2 18:47:49.228239 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37
Oct 2 18:47:49.228257 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38
Oct 2 18:47:49.228274 kernel: iommu: Default domain type: Translated
Oct 2 18:47:49.228292 kernel: iommu: DMA domain TLB invalidation policy: strict mode
Oct 2 18:47:49.228310 kernel: vgaarb: loaded
Oct 2 18:47:49.228327 kernel: pps_core: LinuxPPS API ver. 1 registered
Oct 2 18:47:49.228345 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
Oct 2 18:47:49.228366 kernel: PTP clock support registered
Oct 2 18:47:49.228383 kernel: Registered efivars operations
Oct 2 18:47:49.228401 kernel: clocksource: Switched to clocksource arch_sys_counter
Oct 2 18:47:49.228419 kernel: VFS: Disk quotas dquot_6.6.0
Oct 2 18:47:49.228436 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Oct 2 18:47:49.232507 kernel: pnp: PnP ACPI init
Oct 2 18:47:49.232817 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved
Oct 2 18:47:49.232845 kernel: pnp: PnP ACPI: found 1 devices
Oct 2 18:47:49.232863 kernel: NET: Registered PF_INET protocol family
Oct 2 18:47:49.232888 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
Oct 2 18:47:49.232906 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
Oct 2 18:47:49.232922 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Oct 2 18:47:49.232939 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
Oct 2 18:47:49.232955 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
Oct 2 18:47:49.232972 kernel: TCP: Hash tables configured (established 32768 bind 32768)
Oct 2 18:47:49.232989 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
Oct 2 18:47:49.233005 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
Oct 2 18:47:49.233021 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Oct 2 18:47:49.233062 kernel: PCI: CLS 0 bytes, default 64
Oct 2 18:47:49.233080 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available
Oct 2 18:47:49.233097 kernel: kvm [1]: HYP mode not available
Oct 2 18:47:49.233114 kernel: Initialise system trusted keyrings
Oct 2 18:47:49.233131 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
Oct 2 18:47:49.233148 kernel: Key type asymmetric registered
Oct 2 18:47:49.233164 kernel: Asymmetric key parser 'x509' registered
Oct 2 18:47:49.233180 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Oct 2 18:47:49.233196 kernel: io scheduler mq-deadline registered
Oct 2 18:47:49.233218 kernel: io scheduler kyber registered
Oct 2 18:47:49.233235 kernel: io scheduler bfq registered
Oct 2 18:47:49.233616 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered
Oct 2 18:47:49.233644 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
Oct 2 18:47:49.233661 kernel: ACPI: button: Power Button [PWRB]
Oct 2 18:47:49.233678 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Oct 2 18:47:49.233696 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37
Oct 2 18:47:49.233904 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012)
Oct 2 18:47:49.233936 kernel: printk: console [ttyS0] disabled
Oct 2 18:47:49.233955 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A
Oct 2 18:47:49.233972 kernel: printk: console [ttyS0] enabled
Oct 2 18:47:49.233988 kernel: printk: bootconsole [uart0] disabled
Oct 2 18:47:49.234005 kernel: thunder_xcv, ver 1.0
Oct 2 18:47:49.234021 kernel: thunder_bgx, ver 1.0
Oct 2 18:47:49.234037 kernel: nicpf, ver 1.0
Oct 2 18:47:49.234053 kernel: nicvf, ver 1.0
Oct 2 18:47:49.234252 kernel: rtc-efi rtc-efi.0: registered as rtc0
Oct 2 18:47:49.234440 kernel: rtc-efi rtc-efi.0: setting system clock to 2023-10-02T18:47:48 UTC (1696272468)
Oct 2 18:47:49.234482 kernel: hid: raw HID events driver (C) Jiri Kosina
Oct 2 18:47:49.234501 kernel: NET: Registered PF_INET6 protocol family
Oct 2 18:47:49.235327 kernel: Segment Routing with IPv6
Oct 2 18:47:49.235359 kernel: In-situ OAM (IOAM) with IPv6
Oct 2 18:47:49.235377 kernel: NET: Registered PF_PACKET protocol family
Oct 2 18:47:49.235393 kernel: Key type dns_resolver registered
Oct 2 18:47:49.235410 kernel: registered taskstats version 1
Oct 2 18:47:49.235432 kernel: Loading compiled-in X.509 certificates
Oct 2 18:47:49.235449 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.132-flatcar: 3a2a38edc68cb70dc60ec0223a6460557b3bb28d'
Oct 2 18:47:49.235502 kernel: Key type .fscrypt registered
Oct 2 18:47:49.235519 kernel: Key type fscrypt-provisioning registered
Oct 2 18:47:49.235535 kernel: ima: No TPM chip found, activating TPM-bypass!
Oct 2 18:47:49.235551 kernel: ima: Allocated hash algorithm: sha1
Oct 2 18:47:49.235567 kernel: ima: No architecture policies found
Oct 2 18:47:49.235583 kernel: Freeing unused kernel memory: 34560K
Oct 2 18:47:49.235600 kernel: Run /init as init process
Oct 2 18:47:49.235620 kernel: with arguments:
Oct 2 18:47:49.235637 kernel: /init
Oct 2 18:47:49.235652 kernel: with environment:
Oct 2 18:47:49.235669 kernel: HOME=/
Oct 2 18:47:49.235685 kernel: TERM=linux
Oct 2 18:47:49.235701 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a
Oct 2 18:47:49.235723 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)
Oct 2 18:47:49.235744 systemd[1]: Detected virtualization amazon.
Oct 2 18:47:49.235767 systemd[1]: Detected architecture arm64.
Oct 2 18:47:49.235784 systemd[1]: Running in initrd.
Oct 2 18:47:49.235801 systemd[1]: No hostname configured, using default hostname.
Oct 2 18:47:49.235818 systemd[1]: Hostname set to <localhost>.
Oct 2 18:47:49.235836 systemd[1]: Initializing machine ID from VM UUID.
Oct 2 18:47:49.235854 systemd[1]: Queued start job for default target initrd.target.
Oct 2 18:47:49.235871 systemd[1]: Started systemd-ask-password-console.path.
Oct 2 18:47:49.235888 systemd[1]: Reached target cryptsetup.target.
Oct 2 18:47:49.235909 systemd[1]: Reached target paths.target.
Oct 2 18:47:49.235926 systemd[1]: Reached target slices.target.
Oct 2 18:47:49.235944 systemd[1]: Reached target swap.target.
Oct 2 18:47:49.235961 systemd[1]: Reached target timers.target.
Oct 2 18:47:49.235979 systemd[1]: Listening on iscsid.socket.
Oct 2 18:47:49.235996 systemd[1]: Listening on iscsiuio.socket.
Oct 2 18:47:49.236014 systemd[1]: Listening on systemd-journald-audit.socket.
Oct 2 18:47:49.236031 systemd[1]: Listening on systemd-journald-dev-log.socket.
Oct 2 18:47:49.236053 systemd[1]: Listening on systemd-journald.socket.
Oct 2 18:47:49.236070 systemd[1]: Listening on systemd-networkd.socket.
Oct 2 18:47:49.236088 systemd[1]: Listening on systemd-udevd-control.socket.
Oct 2 18:47:49.236105 systemd[1]: Listening on systemd-udevd-kernel.socket.
Oct 2 18:47:49.236123 systemd[1]: Reached target sockets.target.
Oct 2 18:47:49.236140 systemd[1]: Starting kmod-static-nodes.service...
Oct 2 18:47:49.236158 systemd[1]: Finished network-cleanup.service.
Oct 2 18:47:49.236175 systemd[1]: Starting systemd-fsck-usr.service...
Oct 2 18:47:49.236193 systemd[1]: Starting systemd-journald.service...
Oct 2 18:47:49.236214 systemd[1]: Starting systemd-modules-load.service...
Oct 2 18:47:49.236232 systemd[1]: Starting systemd-resolved.service...
Oct 2 18:47:49.236249 systemd[1]: Starting systemd-vconsole-setup.service...
Oct 2 18:47:49.236266 systemd[1]: Finished kmod-static-nodes.service.
Oct 2 18:47:49.236284 systemd[1]: Finished systemd-fsck-usr.service.
Oct 2 18:47:49.236301 systemd[1]: Starting systemd-tmpfiles-setup-dev.service...
Oct 2 18:47:49.236319 systemd[1]: Finished systemd-vconsole-setup.service.
Oct 2 18:47:49.236336 systemd[1]: Starting dracut-cmdline-ask.service...
Oct 2 18:47:49.236354 systemd[1]: Finished systemd-tmpfiles-setup-dev.service.
Oct 2 18:47:49.236376 kernel: audit: type=1130 audit(1696272469.214:2): 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'
Oct 2 18:47:49.236398 systemd-journald[308]: Journal started
Oct 2 18:47:49.236506 systemd-journald[308]: Runtime Journal (/run/log/journal/ec2843d2c268a2ef9c2ffaf6ae5f28e2) is 8.0M, max 75.4M, 67.4M free.
Oct 2 18:47:49.214000 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'
Oct 2 18:47:49.170955 systemd-modules-load[309]: Inserted module 'overlay'
Oct 2 18:47:49.253972 systemd[1]: Started systemd-journald.service.
Oct 2 18:47:49.254012 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Oct 2 18:47:49.254037 kernel: Bridge firewalling registered
Oct 2 18:47:49.224469 systemd-resolved[310]: Positive Trust Anchors:
Oct 2 18:47:49.224496 systemd-resolved[310]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Oct 2 18:47:49.224551 systemd-resolved[310]: 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
Oct 2 18:47:49.248394 systemd-modules-load[309]: Inserted module 'br_netfilter'
Oct 2 18:47:49.272000 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'
Oct 2 18:47:49.285483 kernel: audit: type=1130 audit(1696272469.272:3): 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'
Oct 2 18:47:49.285549 kernel: SCSI subsystem initialized
Oct 2 18:47:49.301797 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
Oct 2 18:47:49.301871 kernel: device-mapper: uevent: version 1.0.3
Oct 2 18:47:49.308024 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com
Oct 2 18:47:49.309505 systemd[1]: Finished dracut-cmdline-ask.service.
Oct 2 18:47:49.310000 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'
Oct 2 18:47:49.321814 systemd[1]: Starting dracut-cmdline.service...
Oct 2 18:47:49.324812 kernel: audit: type=1130 audit(1696272469.310:4): 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'
Oct 2 18:47:49.325445 systemd-modules-load[309]: Inserted module 'dm_multipath'
Oct 2 18:47:49.330113 systemd[1]: Finished systemd-modules-load.service.
Oct 2 18:47:49.330000 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'
Oct 2 18:47:49.342509 systemd[1]: Starting systemd-sysctl.service...
Oct 2 18:47:49.346250 kernel: audit: type=1130 audit(1696272469.330:5): 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'
Oct 2 18:47:49.388292 dracut-cmdline[325]: dracut-dracut-053
Oct 2 18:47:49.391035 systemd[1]: Finished systemd-sysctl.service.
Oct 2 18:47:49.391000 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'
Oct 2 18:47:49.402428 dracut-cmdline[325]: 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=684fe6a2259d7fb96810743ab87aaaa03d9f185b113bd6990a64d1079e5672ca
Oct 2 18:47:49.414305 kernel: audit: type=1130 audit(1696272469.391:6): 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'
Oct 2 18:47:49.633511 kernel: Loading iSCSI transport class v2.0-870.
Oct 2 18:47:49.648515 kernel: iscsi: registered transport (tcp)
Oct 2 18:47:49.674770 kernel: iscsi: registered transport (qla4xxx)
Oct 2 18:47:49.674839 kernel: QLogic iSCSI HBA Driver
Oct 2 18:47:49.860510 kernel: random: crng init done
Oct 2 18:47:49.860601 systemd-resolved[310]: Defaulting to hostname 'linux'.
Oct 2 18:47:49.864257 systemd[1]: Started systemd-resolved.service.
Oct 2 18:47:49.865000 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'
Oct 2 18:47:49.874655 systemd[1]: Reached target nss-lookup.target.
Oct 2 18:47:49.877048 kernel: audit: type=1130 audit(1696272469.865:7): 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'
Oct 2 18:47:49.930332 systemd[1]: Finished dracut-cmdline.service.
Oct 2 18:47:49.929000 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'
Oct 2 18:47:49.934405 systemd[1]: Starting dracut-pre-udev.service...
Oct 2 18:47:49.944880 kernel: audit: type=1130 audit(1696272469.929:8): 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'
Oct 2 18:47:50.027494 kernel: raid6: neonx8 gen() 6291 MB/s
Oct 2 18:47:50.045490 kernel: raid6: neonx8 xor() 4659 MB/s
Oct 2 18:47:50.063491 kernel: raid6: neonx4 gen() 6399 MB/s
Oct 2 18:47:50.081492 kernel: raid6: neonx4 xor() 4825 MB/s
Oct 2 18:47:50.099492 kernel: raid6: neonx2 gen() 5696 MB/s
Oct 2 18:47:50.117488 kernel: raid6: neonx2 xor() 4416 MB/s
Oct 2 18:47:50.135490 kernel: raid6: neonx1 gen() 4428 MB/s
Oct 2 18:47:50.154516 kernel: raid6: neonx1 xor() 3567 MB/s
Oct 2 18:47:50.172492 kernel: raid6: int64x8 gen() 2730 MB/s
Oct 2 18:47:50.190490 kernel: raid6: int64x8 xor() 2078 MB/s
Oct 2 18:47:50.208492 kernel: raid6: int64x4 gen() 3747 MB/s
Oct 2 18:47:50.226490 kernel: raid6: int64x4 xor() 2181 MB/s
Oct 2 18:47:50.244493 kernel: raid6: int64x2 gen() 3528 MB/s
Oct 2 18:47:50.262490 kernel: raid6: int64x2 xor() 1943 MB/s
Oct 2 18:47:50.280490 kernel: raid6: int64x1 gen() 2753 MB/s
Oct 2 18:47:50.300104 kernel: raid6: int64x1 xor() 1442 MB/s
Oct 2 18:47:50.300135 kernel: raid6: using algorithm neonx4 gen() 6399 MB/s
Oct 2 18:47:50.300164 kernel: raid6: .... xor() 4825 MB/s, rmw enabled
Oct 2 18:47:50.301974 kernel: raid6: using neon recovery algorithm
Oct 2 18:47:50.320497 kernel: xor: measuring software checksum speed
Oct 2 18:47:50.323493 kernel: 8regs : 9333 MB/sec
Oct 2 18:47:50.326487 kernel: 32regs : 11107 MB/sec
Oct 2 18:47:50.330359 kernel: arm64_neon : 9305 MB/sec
Oct 2 18:47:50.330391 kernel: xor: using function: 32regs (11107 MB/sec)
Oct 2 18:47:50.422537 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no
Oct 2 18:47:50.462837 systemd[1]: Finished dracut-pre-udev.service.
Oct 2 18:47:50.463000 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'
Oct 2 18:47:50.472000 audit: BPF prog-id=7 op=LOAD
Oct 2 18:47:50.476751 kernel: audit: type=1130 audit(1696272470.463:9): 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'
Oct 2 18:47:50.476805 kernel: audit: type=1334 audit(1696272470.472:10): prog-id=7 op=LOAD
Oct 2 18:47:50.474911 systemd[1]: Starting systemd-udevd.service...
Oct 2 18:47:50.472000 audit: BPF prog-id=8 op=LOAD
Oct 2 18:47:50.512646 systemd-udevd[507]: Using default interface naming scheme 'v252'.
Oct 2 18:47:50.523770 systemd[1]: Started systemd-udevd.service.
Oct 2 18:47:50.524000 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'
Oct 2 18:47:50.530681 systemd[1]: Starting dracut-pre-trigger.service...
Oct 2 18:47:50.592104 dracut-pre-trigger[511]: rd.md=0: removing MD RAID activation
Oct 2 18:47:50.700579 systemd[1]: Finished dracut-pre-trigger.service.
Oct 2 18:47:50.699000 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'
Oct 2 18:47:50.703717 systemd[1]: Starting systemd-udev-trigger.service...
Oct 2 18:47:50.820953 systemd[1]: Finished systemd-udev-trigger.service.
Oct 2 18:47:50.821000 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'
Oct 2 18:47:50.965891 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36
Oct 2 18:47:50.965953 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012)
Oct 2 18:47:50.981401 kernel: ena 0000:00:05.0: ENA device version: 0.10
Oct 2 18:47:50.981693 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1
Oct 2 18:47:50.989498 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35
Oct 2 18:47:50.990483 kernel: nvme nvme0: pci function 0000:00:04.0
Oct 2 18:47:50.999492 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:2c:88:47:38:6d
Oct 2 18:47:51.004492 kernel: nvme nvme0: 2/0/0 default/read/poll queues
Oct 2 18:47:51.010988 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk.
Oct 2 18:47:51.011032 kernel: GPT:9289727 != 16777215
Oct 2 18:47:51.013325 kernel: GPT:Alternate GPT header not at the end of the disk.
Oct 2 18:47:51.014714 kernel: GPT:9289727 != 16777215
Oct 2 18:47:51.016674 kernel: GPT: Use GNU Parted to correct GPT errors.
Oct 2 18:47:51.018292 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9
Oct 2 18:47:51.022382 (udev-worker)[561]: Network interface NamePolicy= disabled on kernel command line.
Oct 2 18:47:51.109499 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by (udev-worker) (567)
Oct 2 18:47:51.229436 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device.
Oct 2 18:47:51.278540 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device.
Oct 2 18:47:51.284777 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device.
Oct 2 18:47:51.291229 systemd[1]: Starting disk-uuid.service...
Oct 2 18:47:51.322392 disk-uuid[671]: Primary Header is updated.
Oct 2 18:47:51.322392 disk-uuid[671]: Secondary Entries is updated.
Oct 2 18:47:51.322392 disk-uuid[671]: Secondary Header is updated.
Oct 2 18:47:51.364277 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device.
Oct 2 18:47:51.378549 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device.
Oct 2 18:47:52.342491 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9
Oct 2 18:47:52.342944 disk-uuid[672]: The operation has completed successfully.
Oct 2 18:47:52.629668 systemd[1]: disk-uuid.service: Deactivated successfully.
Oct 2 18:47:52.631000 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'
Oct 2 18:47:52.631000 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'
Oct 2 18:47:52.629869 systemd[1]: Finished disk-uuid.service.
Oct 2 18:47:52.636273 systemd[1]: Starting verity-setup.service...
Oct 2 18:47:52.691506 kernel: device-mapper: verity: sha256 using implementation "sha256-ce"
Oct 2 18:47:52.777422 systemd[1]: Found device dev-mapper-usr.device.
Oct 2 18:47:52.784395 systemd[1]: Mounting sysusr-usr.mount...
Oct 2 18:47:52.793222 systemd[1]: Finished verity-setup.service.
Oct 2 18:47:52.799517 kernel: kauditd_printk_skb: 6 callbacks suppressed
Oct 2 18:47:52.799584 kernel: audit: type=1130 audit(1696272472.794:17): 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'
Oct 2 18:47:52.794000 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'
Oct 2 18:47:52.885499 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none.
Oct 2 18:47:52.886779 systemd[1]: Mounted sysusr-usr.mount.
Oct 2 18:47:52.889758 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met.
Oct 2 18:47:52.893852 systemd[1]: Starting ignition-setup.service...
Oct 2 18:47:52.896748 systemd[1]: Starting parse-ip-for-networkd.service...
Oct 2 18:47:52.937241 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm
Oct 2 18:47:52.937308 kernel: BTRFS info (device nvme0n1p6): using free space tree
Oct 2 18:47:52.937333 kernel: BTRFS info (device nvme0n1p6): has skinny extents
Oct 2 18:47:52.959476 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations
Oct 2 18:47:52.995444 systemd[1]: mnt-oem.mount: Deactivated successfully.
Oct 2 18:47:53.044440 systemd[1]: Finished ignition-setup.service.
Oct 2 18:47:53.046000 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'
Oct 2 18:47:53.049109 systemd[1]: Starting ignition-fetch-offline.service...
Oct 2 18:47:53.060575 kernel: audit: type=1130 audit(1696272473.046:18): 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'
Oct 2 18:47:53.265975 systemd[1]: Finished parse-ip-for-networkd.service.
Oct 2 18:47:53.277386 kernel: audit: type=1130 audit(1696272473.266:19): 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'
Oct 2 18:47:53.266000 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'
Oct 2 18:47:53.277000 audit: BPF prog-id=9 op=LOAD
Oct 2 18:47:53.279489 systemd[1]: Starting systemd-networkd.service...
Oct 2 18:47:53.285308 kernel: audit: type=1334 audit(1696272473.277:20): prog-id=9 op=LOAD
Oct 2 18:47:53.334824 systemd-networkd[1185]: lo: Link UP
Oct 2 18:47:53.334846 systemd-networkd[1185]: lo: Gained carrier
Oct 2 18:47:53.338422 systemd-networkd[1185]: Enumeration completed
Oct 2 18:47:53.340175 systemd-networkd[1185]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Oct 2 18:47:53.342620 systemd[1]: Started systemd-networkd.service.
Oct 2 18:47:53.345000 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'
Oct 2 18:47:53.347066 systemd[1]: Reached target network.target.
Oct 2 18:47:53.358709 kernel: audit: type=1130 audit(1696272473.345:21): 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'
Oct 2 18:47:53.359834 systemd-networkd[1185]: eth0: Link UP
Oct 2 18:47:53.359853 systemd-networkd[1185]: eth0: Gained carrier
Oct 2 18:47:53.363378 systemd[1]: Starting iscsiuio.service...
Oct 2 18:47:53.373251 systemd-networkd[1185]: eth0: DHCPv4 address 172.31.19.37/20, gateway 172.31.16.1 acquired from 172.31.16.1
Oct 2 18:47:53.386868 systemd[1]: Started iscsiuio.service.
Oct 2 18:47:53.391000 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'
Oct 2 18:47:53.399991 systemd[1]: Starting iscsid.service...
Oct 2 18:47:53.403234 kernel: audit: type=1130 audit(1696272473.391:22): 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'
Oct 2 18:47:53.416673 iscsid[1191]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi
Oct 2 18:47:53.416673 iscsid[1191]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.<reversed domain name>[:identifier].
Oct 2 18:47:53.416673 iscsid[1191]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6.
Oct 2 18:47:53.416673 iscsid[1191]: If using hardware iscsi like qla4xxx this message can be ignored.
Oct 2 18:47:53.416673 iscsid[1191]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi
Oct 2 18:47:53.437327 iscsid[1191]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf
Oct 2 18:47:53.449011 systemd[1]: Started iscsid.service.
Oct 2 18:47:53.449000 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'
Oct 2 18:47:53.453201 systemd[1]: Starting dracut-initqueue.service...
Oct 2 18:47:53.474499 kernel: audit: type=1130 audit(1696272473.449:23): 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'
Oct 2 18:47:53.499980 systemd[1]: Finished dracut-initqueue.service.
Oct 2 18:47:53.498000 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'
Oct 2 18:47:53.501283 systemd[1]: Reached target remote-fs-pre.target.
Oct 2 18:47:53.527926 kernel: audit: type=1130 audit(1696272473.498:24): 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'
Oct 2 18:47:53.502080 systemd[1]: Reached target remote-cryptsetup.target.
Oct 2 18:47:53.502174 systemd[1]: Reached target remote-fs.target.
Oct 2 18:47:53.505950 systemd[1]: Starting dracut-pre-mount.service...
Oct 2 18:47:53.549784 systemd[1]: Finished dracut-pre-mount.service.
Oct 2 18:47:53.548000 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'
Oct 2 18:47:53.561541 kernel: audit: type=1130 audit(1696272473.548:25): 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'
Oct 2 18:47:53.609979 ignition[1109]: Ignition 2.14.0
Oct 2 18:47:53.610012 ignition[1109]: Stage: fetch-offline
Oct 2 18:47:53.610424 ignition[1109]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Oct 2 18:47:53.611269 ignition[1109]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Oct 2 18:47:53.631148 ignition[1109]: no config dir at "/usr/lib/ignition/base.platform.d/aws"
Oct 2 18:47:53.632168 ignition[1109]: Ignition finished successfully
Oct 2 18:47:53.636903 systemd[1]: Finished ignition-fetch-offline.service.
Oct 2 18:47:53.640253 systemd[1]: Starting ignition-fetch.service...
Oct 2 18:47:53.637000 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'
Oct 2 18:47:53.665525 kernel: audit: type=1130 audit(1696272473.637:26): 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'
Oct 2 18:47:53.671480 ignition[1209]: Ignition 2.14.0
Oct 2 18:47:53.671509 ignition[1209]: Stage: fetch
Oct 2 18:47:53.671878 ignition[1209]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Oct 2 18:47:53.671991 ignition[1209]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Oct 2 18:47:53.688042 ignition[1209]: no config dir at "/usr/lib/ignition/base.platform.d/aws"
Oct 2 18:47:53.690441 ignition[1209]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Oct 2 18:47:53.709048 ignition[1209]: INFO : PUT result: OK
Oct 2 18:47:53.712754 ignition[1209]: DEBUG : parsed url from cmdline: ""
Oct 2 18:47:53.714734 ignition[1209]: INFO : no config URL provided
Oct 2 18:47:53.714734 ignition[1209]: INFO : reading system config file "/usr/lib/ignition/user.ign"
Oct 2 18:47:53.714734 ignition[1209]: INFO : no config at "/usr/lib/ignition/user.ign"
Oct 2 18:47:53.714734 ignition[1209]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Oct 2 18:47:53.723699 ignition[1209]: INFO : PUT result: OK
Oct 2 18:47:53.725614 ignition[1209]: INFO : GET http://169.254.169.254/2019-10-01/user-data: attempt #1
Oct 2 18:47:53.728151 ignition[1209]: INFO : GET result: OK
Oct 2 18:47:53.729870 ignition[1209]: DEBUG : parsing config with SHA512: 6637a53cdc2a69ebdc5a8340144f3f1b177156e0442558a2c5f3cb4eea300eac49d140ec7463ce7e3c05f03299b4c99f5c1999d430a79e795523fb648c2b89c1
Oct 2 18:47:53.729897 ignition[1209]: not a config (empty): provider config was empty, continuing with empty cache config
Oct 2 18:47:53.738845 unknown[1209]: fetched base config from "system"
Oct 2 18:47:53.739072 unknown[1209]: fetched base config from "system"
Oct 2 18:47:53.739644 ignition[1209]: fetch: fetch complete
Oct 2 18:47:53.742874 systemd[1]: Finished ignition-fetch.service.
Oct 2 18:47:53.739657 ignition[1209]: fetch: fetch passed
Oct 2 18:47:53.739761 ignition[1209]: Ignition finished successfully
Oct 2 18:47:53.751405 systemd[1]: Starting ignition-kargs.service...
Oct 2 18:47:53.748000 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'
Oct 2 18:47:53.785327 ignition[1215]: Ignition 2.14.0
Oct 2 18:47:53.785357 ignition[1215]: Stage: kargs
Oct 2 18:47:53.785751 ignition[1215]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Oct 2 18:47:53.785810 ignition[1215]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Oct 2 18:47:53.802338 ignition[1215]: no config dir at "/usr/lib/ignition/base.platform.d/aws"
Oct 2 18:47:53.804814 ignition[1215]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Oct 2 18:47:53.808494 ignition[1215]: INFO : PUT result: OK
Oct 2 18:47:53.812837 ignition[1215]: kargs: kargs passed
Oct 2 18:47:53.812950 ignition[1215]: Ignition finished successfully
Oct 2 18:47:53.820162 systemd[1]: Finished ignition-kargs.service.
Oct 2 18:47:53.821000 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'
Oct 2 18:47:53.824748 systemd[1]: Starting ignition-disks.service...
Oct 2 18:47:53.855271 ignition[1221]: Ignition 2.14.0
Oct 2 18:47:53.855300 ignition[1221]: Stage: disks
Oct 2 18:47:53.855684 ignition[1221]: reading system config file "/usr/lib/ignition/base.d/base.ign"
Oct 2 18:47:53.855742 ignition[1221]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Oct 2 18:47:53.871943 ignition[1221]: no config dir at "/usr/lib/ignition/base.platform.d/aws"
Oct 2 18:47:53.874388 ignition[1221]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Oct 2 18:47:53.882512 ignition[1221]: INFO : PUT result: OK
Oct 2 18:47:53.886239 ignition[1221]: disks: disks passed
Oct 2 18:47:53.886380 ignition[1221]: Ignition finished successfully
Oct 2 18:47:53.890525 systemd[1]: Finished ignition-disks.service.
Oct 2 18:47:53.889000 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'
Oct 2 18:47:53.891869 systemd[1]: Reached target initrd-root-device.target.
Oct 2 18:47:53.892103 systemd[1]: Reached target local-fs-pre.target.
Oct 2 18:47:53.892433 systemd[1]: Reached target local-fs.target.
Oct 2 18:47:53.893789 systemd[1]: Reached target sysinit.target.
Oct 2 18:47:53.894962 systemd[1]: Reached target basic.target.
Oct 2 18:47:53.896815 systemd[1]: Starting systemd-fsck-root.service...
Oct 2 18:47:53.959245 systemd-fsck[1229]: ROOT: clean, 603/553520 files, 56011/553472 blocks
Oct 2 18:47:53.969809 systemd[1]: Finished systemd-fsck-root.service.
Oct 2 18:47:53.974398 systemd[1]: Mounting sysroot.mount...
Oct 2 18:47:53.968000 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'
Oct 2 18:47:53.998515 kernel: EXT4-fs (nvme0n1p9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
Oct 2 18:47:54.000348 systemd[1]: Mounted sysroot.mount.
Oct 2 18:47:54.003158 systemd[1]: Reached target initrd-root-fs.target.
Oct 2 18:47:54.018605 systemd[1]: Mounting sysroot-usr.mount...
Oct 2 18:47:54.020931 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met.
Oct 2 18:47:54.021036 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
Oct 2 18:47:54.021104 systemd[1]: Reached target ignition-diskful.target.
Oct 2 18:47:54.038676 systemd[1]: Mounted sysroot-usr.mount.
Oct 2 18:47:54.054603 systemd[1]: Mounting sysroot-usr-share-oem.mount...
Oct 2 18:47:54.061229 systemd[1]: Starting initrd-setup-root.service...
Oct 2 18:47:54.094959 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by mount (1246)
Oct 2 18:47:54.100674 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm
Oct 2 18:47:54.100712 kernel: BTRFS info (device nvme0n1p6): using free space tree
Oct 2 18:47:54.100736 kernel: BTRFS info (device nvme0n1p6): has skinny extents
Oct 2 18:47:54.103093 initrd-setup-root[1251]: cut: /sysroot/etc/passwd: No such file or directory
Oct 2 18:47:54.114492 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations
Oct 2 18:47:54.119812 systemd[1]: Mounted sysroot-usr-share-oem.mount.
Oct 2 18:47:54.145679 initrd-setup-root[1277]: cut: /sysroot/etc/group: No such file or directory
Oct 2 18:47:54.162829 initrd-setup-root[1285]: cut: /sysroot/etc/shadow: No such file or directory
Oct 2 18:47:54.180597 initrd-setup-root[1293]: cut: /sysroot/etc/gshadow: No such file or directory
Oct 2 18:47:54.387705 systemd[1]: Finished initrd-setup-root.service.
Oct 2 18:47:54.389000 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'
Oct 2 18:47:54.392385 systemd[1]: Starting ignition-mount.service...
Oct 2 18:47:54.411335 systemd[1]: Starting sysroot-boot.service...
Oct 2 18:47:54.433782 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully.
Oct 2 18:47:54.433970 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully.
Oct 2 18:47:54.467000 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'
Oct 2 18:47:54.466941 systemd[1]: Finished sysroot-boot.service.
Oct 2 18:47:54.485776 ignition[1313]: INFO : Ignition 2.14.0
Oct 2 18:47:54.485776 ignition[1313]: INFO : Stage: mount
Oct 2 18:47:54.489322 ignition[1313]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"
Oct 2 18:47:54.489322 ignition[1313]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Oct 2 18:47:54.509050 ignition[1313]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws"
Oct 2 18:47:54.509050 ignition[1313]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Oct 2 18:47:54.514170 ignition[1313]: INFO : PUT result: OK
Oct 2 18:47:54.527271 ignition[1313]: INFO : mount: mount passed
Oct 2 18:47:54.541177 ignition[1313]: INFO : Ignition finished successfully
Oct 2 18:47:54.544054 systemd[1]: Finished ignition-mount.service.
Oct 2 18:47:54.546000 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'
Oct 2 18:47:54.548564 systemd[1]: Starting ignition-files.service...
Oct 2 18:47:54.571741 systemd[1]: Mounting sysroot-usr-share-oem.mount...
Oct 2 18:47:54.595493 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by mount (1321)
Oct 2 18:47:54.601530 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm
Oct 2 18:47:54.601575 kernel: BTRFS info (device nvme0n1p6): using free space tree
Oct 2 18:47:54.603842 kernel: BTRFS info (device nvme0n1p6): has skinny extents
Oct 2 18:47:54.610497 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations
Oct 2 18:47:54.616132 systemd[1]: Mounted sysroot-usr-share-oem.mount.
Oct 2 18:47:54.650307 ignition[1340]: INFO : Ignition 2.14.0
Oct 2 18:47:54.650307 ignition[1340]: INFO : Stage: files
Oct 2 18:47:54.653980 ignition[1340]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"
Oct 2 18:47:54.653980 ignition[1340]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Oct 2 18:47:54.669932 ignition[1340]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws"
Oct 2 18:47:54.672618 ignition[1340]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Oct 2 18:47:54.675974 ignition[1340]: INFO : PUT result: OK
Oct 2 18:47:54.680506 ignition[1340]: DEBUG : files: compiled without relabeling support, skipping
Oct 2 18:47:54.683183 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(1): [started] writing file "/sysroot/etc/eks/bootstrap.sh"
Oct 2 18:47:54.687104 ignition[1340]: INFO : oem config not found in "/usr/share/oem", looking on oem partition
Oct 2 18:47:54.699297 ignition[1340]: INFO : op(1): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3745828799"
Oct 2 18:47:54.707615 kernel: BTRFS info: devid 1 device path /dev/nvme0n1p6 changed to /dev/disk/by-label/OEM scanned by ignition (1345)
Oct 2 18:47:54.707654 ignition[1340]: CRITICAL : op(1): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3745828799": device or resource busy
Oct 2 18:47:54.707654 ignition[1340]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3745828799", trying btrfs: device or resource busy
Oct 2 18:47:54.707654 ignition[1340]: INFO : op(2): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3745828799"
Oct 2 18:47:54.718344 ignition[1340]: INFO : op(2): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3745828799"
Oct 2 18:47:54.718344 ignition[1340]: INFO : op(3): [started] unmounting "/mnt/oem3745828799"
Oct 2 18:47:54.724071 ignition[1340]: INFO : op(3): [finished] unmounting "/mnt/oem3745828799"
Oct 2 18:47:54.724071 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(1): [finished] writing file "/sysroot/etc/eks/bootstrap.sh"
Oct 2 18:47:54.724071 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(2): [started] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json"
Oct 2 18:47:54.724071 ignition[1340]: INFO : oem config not found in "/usr/share/oem", looking on oem partition
Oct 2 18:47:54.747824 ignition[1340]: INFO : op(4): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3337113486"
Oct 2 18:47:54.747824 ignition[1340]: CRITICAL : op(4): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3337113486": device or resource busy
Oct 2 18:47:54.747824 ignition[1340]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3337113486", trying btrfs: device or resource busy
Oct 2 18:47:54.747824 ignition[1340]: INFO : op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3337113486"
Oct 2 18:47:54.760395 ignition[1340]: INFO : op(5): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3337113486"
Oct 2 18:47:54.763955 ignition[1340]: INFO : op(6): [started] unmounting "/mnt/oem3337113486"
Oct 2 18:47:54.773161 ignition[1340]: INFO : op(6): [finished] unmounting "/mnt/oem3337113486"
Oct 2 18:47:54.773161 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(2): [finished] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json"
Oct 2 18:47:54.773161 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/amazon/ssm/seelog.xml"
Oct 2 18:47:54.773161 ignition[1340]: INFO : oem config not found in "/usr/share/oem", looking on oem partition
Oct 2 18:47:54.789833 ignition[1340]: INFO : op(7): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1174376557"
Oct 2 18:47:54.789833 ignition[1340]: CRITICAL : op(7): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1174376557": device or resource busy
Oct 2 18:47:54.789833 ignition[1340]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem1174376557", trying btrfs: device or resource busy
Oct 2 18:47:54.789833 ignition[1340]: INFO : op(8): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1174376557"
Oct 2 18:47:54.789833 ignition[1340]: INFO : op(8): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1174376557"
Oct 2 18:47:54.805604 ignition[1340]: INFO : op(9): [started] unmounting "/mnt/oem1174376557"
Oct 2 18:47:54.807900 ignition[1340]: INFO : op(9): [finished] unmounting "/mnt/oem1174376557"
Oct 2 18:47:54.810356 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/amazon/ssm/seelog.xml"
Oct 2 18:47:54.814209 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/systemd/system/nvidia.service"
Oct 2 18:47:54.818103 ignition[1340]: INFO : oem config not found in "/usr/share/oem", looking on oem partition
Oct 2 18:47:54.833205 ignition[1340]: INFO : op(a): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem626878626"
Oct 2 18:47:54.836213 ignition[1340]: CRITICAL : op(a): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem626878626": device or resource busy
Oct 2 18:47:54.836213 ignition[1340]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem626878626", trying btrfs: device or resource busy
Oct 2 18:47:54.836213 ignition[1340]: INFO : op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem626878626"
Oct 2 18:47:54.846599 ignition[1340]: INFO : op(b): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem626878626"
Oct 2 18:47:54.846599 ignition[1340]: INFO : op(c): [started] unmounting "/mnt/oem626878626"
Oct 2 18:47:54.846599 ignition[1340]: INFO : op(c): [finished] unmounting "/mnt/oem626878626"
Oct 2 18:47:54.846599 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(5): [started] processing unit "nvidia.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(5): [finished] processing unit "nvidia.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(6): [started] processing unit "coreos-metadata-sshkeys@.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(6): [finished] processing unit "coreos-metadata-sshkeys@.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(7): [started] processing unit "amazon-ssm-agent.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(7): op(8): [started] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(7): op(8): [finished] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(7): [finished] processing unit "amazon-ssm-agent.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(9): [started] setting preset to enabled for "nvidia.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(9): [finished] setting preset to enabled for "nvidia.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(a): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service "
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(a): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service "
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(b): [started] setting preset to enabled for "amazon-ssm-agent.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: op(b): [finished] setting preset to enabled for "amazon-ssm-agent.service"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: createResultFile: createFiles: op(c): [started] writing file "/sysroot/etc/.ignition-result.json"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: createResultFile: createFiles: op(c): [finished] writing file "/sysroot/etc/.ignition-result.json"
Oct 2 18:47:54.863513 ignition[1340]: INFO : files: files passed
Oct 2 18:47:54.863513 ignition[1340]: INFO : Ignition finished successfully
Oct 2 18:47:54.871000 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'
Oct 2 18:47:54.870082 systemd[1]: Finished ignition-files.service.
Oct 2 18:47:54.879447 systemd[1]: Starting initrd-setup-root-after-ignition.service...
Oct 2 18:47:54.892523 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile).
Oct 2 18:47:54.904332 systemd[1]: Starting ignition-quench.service...
Oct 2 18:47:54.967626 systemd[1]: ignition-quench.service: Deactivated successfully.
Oct 2 18:47:54.969000 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'
Oct 2 18:47:54.969000 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'
Oct 2 18:47:54.967815 systemd[1]: Finished ignition-quench.service.
Oct 2 18:47:54.978720 initrd-setup-root-after-ignition[1357]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Oct 2 18:47:54.984065 systemd[1]: Finished initrd-setup-root-after-ignition.service.
Oct 2 18:47:54.984000 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'
Oct 2 18:47:54.986373 systemd[1]: Reached target ignition-complete.target.
Oct 2 18:47:55.003134 systemd[1]: Starting initrd-parse-etc.service...
Oct 2 18:47:55.053924 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
Oct 2 18:47:55.055983 systemd[1]: Finished initrd-parse-etc.service.
Oct 2 18:47:55.056000 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'
Oct 2 18:47:55.056000 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'
Oct 2 18:47:55.059745 systemd[1]: Reached target initrd-fs.target.
Oct 2 18:47:55.062959 systemd[1]: Reached target initrd.target.
Oct 2 18:47:55.066065 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met.
Oct 2 18:47:55.070035 systemd[1]: Starting dracut-pre-pivot.service...
Oct 2 18:47:55.111686 systemd[1]: Finished dracut-pre-pivot.service.
Oct 2 18:47:55.113000 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'
Oct 2 18:47:55.116445 systemd[1]: Starting initrd-cleanup.service...
Oct 2 18:47:55.145677 systemd[1]: Stopped target nss-lookup.target.
Oct 2 18:47:55.149378 systemd[1]: Stopped target remote-cryptsetup.target.
Oct 2 18:47:55.153277 systemd[1]: Stopped target timers.target.
Oct 2 18:47:55.156599 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
Oct 2 18:47:55.158890 systemd[1]: Stopped dracut-pre-pivot.service.
Oct 2 18:47:55.161000 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'
Oct 2 18:47:55.162744 systemd[1]: Stopped target initrd.target.
Oct 2 18:47:55.166108 systemd[1]: Stopped target basic.target.
Oct 2 18:47:55.169369 systemd[1]: Stopped target ignition-complete.target.
Oct 2 18:47:55.173212 systemd[1]: Stopped target ignition-diskful.target.
Oct 2 18:47:55.177029 systemd[1]: Stopped target initrd-root-device.target.
Oct 2 18:47:55.180853 systemd[1]: Stopped target remote-fs.target.
Oct 2 18:47:55.184249 systemd[1]: Stopped target remote-fs-pre.target.
Oct 2 18:47:55.187914 systemd[1]: Stopped target sysinit.target.
Oct 2 18:47:55.191285 systemd[1]: Stopped target local-fs.target.
Oct 2 18:47:55.194728 systemd[1]: Stopped target local-fs-pre.target.
Oct 2 18:47:55.198283 systemd[1]: Stopped target swap.target.
Oct 2 18:47:55.201451 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
Oct 2 18:47:55.203770 systemd[1]: Stopped dracut-pre-mount.service.
Oct 2 18:47:55.206000 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'
Oct 2 18:47:55.207662 systemd[1]: Stopped target cryptsetup.target.
Oct 2 18:47:55.211174 systemd[1]: dracut-initqueue.service: Deactivated successfully.
Oct 2 18:47:55.213450 systemd[1]: Stopped dracut-initqueue.service.
Oct 2 18:47:55.215000 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'
Oct 2 18:47:55.217244 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
Oct 2 18:47:55.219919 systemd[1]: Stopped initrd-setup-root-after-ignition.service.
Oct 2 18:47:55.222000 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'
Oct 2 18:47:55.224171 systemd[1]: ignition-files.service: Deactivated successfully.
Oct 2 18:47:55.224392 systemd[1]: Stopped ignition-files.service.
Oct 2 18:47:55.228000 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'
Oct 2 18:47:55.231289 systemd[1]: Stopping ignition-mount.service...
Oct 2 18:47:55.248960 iscsid[1191]: iscsid shutting down.
Oct 2 18:47:55.256533 systemd[1]: Stopping iscsid.service...
Oct 2 18:47:55.264267 systemd[1]: Stopping sysroot-boot.service...
Oct 2 18:47:55.267243 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
Oct 2 18:47:55.269653 systemd[1]: Stopped systemd-udev-trigger.service.
Oct 2 18:47:55.274023 ignition[1370]: INFO : Ignition 2.14.0
Oct 2 18:47:55.275871 ignition[1370]: INFO : Stage: umount
Oct 2 18:47:55.275871 ignition[1370]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign"
Oct 2 18:47:55.275871 ignition[1370]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b
Oct 2 18:47:55.288000 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'
Oct 2 18:47:55.289738 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
Oct 2 18:47:55.292570 systemd[1]: Stopped dracut-pre-trigger.service.
Oct 2 18:47:55.293000 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'
Oct 2 18:47:55.299656 systemd[1]: iscsid.service: Deactivated successfully.
Oct 2 18:47:55.300765 systemd[1]: Stopped iscsid.service.
Oct 2 18:47:55.303000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 18:47:55.306987 systemd[1]: Stopping iscsiuio.service...
Oct 2 18:47:55.308677 systemd-networkd[1185]: eth0: Gained IPv6LL
Oct 2 18:47:55.318299 ignition[1370]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws"
Oct 2 18:47:55.318299 ignition[1370]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1
Oct 2 18:47:55.328799 systemd[1]: iscsiuio.service: Deactivated successfully.
Oct 2 18:47:55.329873 systemd[1]: Stopped iscsiuio.service.
Oct 2 18:47:55.332000 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'
Oct 2 18:47:55.334672 systemd[1]: initrd-cleanup.service: Deactivated successfully.
Oct 2 18:47:55.335156 systemd[1]: Finished initrd-cleanup.service.
Oct 2 18:47:55.335000 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'
Oct 2 18:47:55.335000 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'
Oct 2 18:47:55.342186 ignition[1370]: INFO : PUT result: OK
Oct 2 18:47:55.352709 ignition[1370]: INFO : umount: umount passed
Oct 2 18:47:55.354623 ignition[1370]: INFO : Ignition finished successfully
Oct 2 18:47:55.358042 systemd[1]: ignition-mount.service: Deactivated successfully.
Oct 2 18:47:55.358000 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'
Oct 2 18:47:55.360000 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'
Oct 2 18:47:55.358235 systemd[1]: Stopped ignition-mount.service.
Oct 2 18:47:55.360243 systemd[1]: ignition-disks.service: Deactivated successfully.
Oct 2 18:47:55.360332 systemd[1]: Stopped ignition-disks.service.
Oct 2 18:47:55.367000 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'
Oct 2 18:47:55.362373 systemd[1]: ignition-kargs.service: Deactivated successfully.
Oct 2 18:47:55.362497 systemd[1]: Stopped ignition-kargs.service.
Oct 2 18:47:55.369664 systemd[1]: ignition-fetch.service: Deactivated successfully.
Oct 2 18:47:55.369754 systemd[1]: Stopped ignition-fetch.service.
Oct 2 18:47:55.379000 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'
Oct 2 18:47:55.380864 systemd[1]: Stopped target network.target.
Oct 2 18:47:55.385613 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
Oct 2 18:47:55.386000 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'
Oct 2 18:47:55.385725 systemd[1]: Stopped ignition-fetch-offline.service.
Oct 2 18:47:55.388498 systemd[1]: Stopped target paths.target.
Oct 2 18:47:55.394607 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
Oct 2 18:47:55.399553 systemd[1]: Stopped systemd-ask-password-console.path.
Oct 2 18:47:55.414000 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'
Oct 2 18:47:55.401642 systemd[1]: Stopped target slices.target.
Oct 2 18:47:55.403344 systemd[1]: Stopped target sockets.target.
Oct 2 18:47:55.410661 systemd[1]: iscsid.socket: Deactivated successfully.
Oct 2 18:47:55.410742 systemd[1]: Closed iscsid.socket.
Oct 2 18:47:55.412291 systemd[1]: iscsiuio.socket: Deactivated successfully.
Oct 2 18:47:55.412367 systemd[1]: Closed iscsiuio.socket.
Oct 2 18:47:55.433000 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'
Oct 2 18:47:55.413916 systemd[1]: ignition-setup.service: Deactivated successfully.
Oct 2 18:47:55.414004 systemd[1]: Stopped ignition-setup.service.
Oct 2 18:47:55.415970 systemd[1]: Stopping systemd-networkd.service...
Oct 2 18:47:55.417692 systemd[1]: Stopping systemd-resolved.service...
Oct 2 18:47:55.426534 systemd-networkd[1185]: eth0: DHCPv6 lease lost
Oct 2 18:47:55.426638 systemd[1]: sysroot-boot.mount: Deactivated successfully.
Oct 2 18:47:55.427586 systemd[1]: systemd-resolved.service: Deactivated successfully.
Oct 2 18:47:55.450000 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'
Oct 2 18:47:55.427786 systemd[1]: Stopped systemd-resolved.service.
Oct 2 18:47:55.443309 systemd[1]: sysroot-boot.service: Deactivated successfully.
Oct 2 18:47:55.446786 systemd[1]: Stopped sysroot-boot.service.
Oct 2 18:47:55.456731 systemd[1]: systemd-networkd.service: Deactivated successfully.
Oct 2 18:47:55.458777 systemd[1]: Stopped systemd-networkd.service.
Oct 2 18:47:55.461000 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'
Oct 2 18:47:55.463471 systemd[1]: systemd-networkd.socket: Deactivated successfully.
Oct 2 18:47:55.463554 systemd[1]: Closed systemd-networkd.socket.
Oct 2 18:47:55.467000 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'
Oct 2 18:47:55.467000 audit: BPF prog-id=6 op=UNLOAD
Oct 2 18:47:55.470000 audit: BPF prog-id=9 op=UNLOAD
Oct 2 18:47:55.467134 systemd[1]: initrd-setup-root.service: Deactivated successfully.
Oct 2 18:47:55.475000 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'
Oct 2 18:47:55.476000 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'
Oct 2 18:47:55.481000 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'
Oct 2 18:47:55.467217 systemd[1]: Stopped initrd-setup-root.service.
Oct 2 18:47:55.471218 systemd[1]: Stopping network-cleanup.service...
Oct 2 18:47:55.474580 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
Oct 2 18:47:55.474689 systemd[1]: Stopped parse-ip-for-networkd.service.
Oct 2 18:47:55.476615 systemd[1]: systemd-sysctl.service: Deactivated successfully.
Oct 2 18:47:55.476696 systemd[1]: Stopped systemd-sysctl.service.
Oct 2 18:47:55.481219 systemd[1]: systemd-modules-load.service: Deactivated successfully.
Oct 2 18:47:55.481309 systemd[1]: Stopped systemd-modules-load.service.
Oct 2 18:47:55.492076 systemd[1]: Stopping systemd-udevd.service...
Oct 2 18:47:55.507918 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully.
Oct 2 18:47:55.524524 systemd[1]: network-cleanup.service: Deactivated successfully.
Oct 2 18:47:55.524914 systemd[1]: Stopped network-cleanup.service.
Oct 2 18:47:55.528000 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'
Oct 2 18:47:55.530735 systemd[1]: systemd-udevd.service: Deactivated successfully.
Oct 2 18:47:55.532946 systemd[1]: Stopped systemd-udevd.service.
Oct 2 18:47:55.534000 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'
Oct 2 18:47:55.536396 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
Oct 2 18:47:55.536505 systemd[1]: Closed systemd-udevd-control.socket.
Oct 2 18:47:55.541990 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
Oct 2 18:47:55.542092 systemd[1]: Closed systemd-udevd-kernel.socket.
Oct 2 18:47:55.545726 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
Oct 2 18:47:55.549296 systemd[1]: Stopped dracut-pre-udev.service.
Oct 2 18:47:55.550000 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'
Oct 2 18:47:55.552442 systemd[1]: dracut-cmdline.service: Deactivated successfully.
Oct 2 18:47:55.552551 systemd[1]: Stopped dracut-cmdline.service.
Oct 2 18:47:55.554000 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'
Oct 2 18:47:55.555990 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Oct 2 18:47:55.559752 systemd[1]: Stopped dracut-cmdline-ask.service.
Oct 2 18:47:55.558000 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'
Oct 2 18:47:55.564528 systemd[1]: Starting initrd-udevadm-cleanup-db.service...
Oct 2 18:47:55.585619 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
Oct 2 18:47:55.592000 audit[1]: SERVICE_STOP 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'
Oct 2 18:47:55.585737 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service.
Oct 2 18:47:55.598000 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'
Oct 2 18:47:55.600000 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'
Oct 2 18:47:55.596427 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
Oct 2 18:47:55.596547 systemd[1]: Stopped kmod-static-nodes.service.
Oct 2 18:47:55.607000 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'
Oct 2 18:47:55.607000 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'
Oct 2 18:47:55.599903 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Oct 2 18:47:55.599978 systemd[1]: Stopped systemd-vconsole-setup.service.
Oct 2 18:47:55.605371 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully.
Oct 2 18:47:55.606294 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
Oct 2 18:47:55.606480 systemd[1]: Finished initrd-udevadm-cleanup-db.service.
Oct 2 18:47:55.609264 systemd[1]: Reached target initrd-switch-root.target.
Oct 2 18:47:55.613351 systemd[1]: Starting initrd-switch-root.service...
Oct 2 18:47:55.640822 systemd[1]: Switching root.
Oct 2 18:47:55.678571 systemd-journald[308]: Journal stopped
Oct 2 18:48:01.431602 systemd-journald[308]: Received SIGTERM from PID 1 (systemd).
Oct 2 18:48:01.432141 kernel: SELinux: Class mctp_socket not defined in policy.
Oct 2 18:48:01.432361 kernel: SELinux: Class anon_inode not defined in policy.
Oct 2 18:48:01.432398 kernel: SELinux: the above unknown classes and permissions will be allowed
Oct 2 18:48:01.432431 kernel: SELinux: policy capability network_peer_controls=1
Oct 2 18:48:01.432481 kernel: SELinux: policy capability open_perms=1
Oct 2 18:48:01.432516 kernel: SELinux: policy capability extended_socket_class=1
Oct 2 18:48:01.432549 kernel: SELinux: policy capability always_check_network=0
Oct 2 18:48:01.432586 kernel: SELinux: policy capability cgroup_seclabel=1
Oct 2 18:48:01.432616 kernel: SELinux: policy capability nnp_nosuid_transition=1
Oct 2 18:48:01.432647 kernel: SELinux: policy capability genfs_seclabel_symlinks=0
Oct 2 18:48:01.432678 kernel: SELinux: policy capability ioctl_skip_cloexec=0
Oct 2 18:48:01.432708 systemd[1]: Successfully loaded SELinux policy in 108.337ms.
Oct 2 18:48:01.432940 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 20.118ms.
Oct 2 18:48:01.433044 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)
Oct 2 18:48:01.433084 systemd[1]: Detected virtualization amazon.
Oct 2 18:48:01.433119 systemd[1]: Detected architecture arm64.
Oct 2 18:48:01.433152 systemd[1]: Detected first boot.
Oct 2 18:48:01.433184 systemd[1]: Initializing machine ID from VM UUID.
Oct 2 18:48:01.433214 systemd[1]: Populated /etc with preset unit settings.
Oct 2 18:48:01.433247 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon.
Oct 2 18:48:01.433286 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon.
Oct 2 18:48:01.433322 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.
Oct 2 18:48:01.433359 kernel: kauditd_printk_skb: 57 callbacks suppressed
Oct 2 18:48:01.433390 kernel: audit: type=1334 audit(1696272480.822:84): prog-id=12 op=LOAD
Oct 2 18:48:01.433425 kernel: audit: type=1334 audit(1696272480.822:85): prog-id=3 op=UNLOAD
Oct 2 18:48:01.433472 systemd[1]: initrd-switch-root.service: Deactivated successfully.
Oct 2 18:48:01.433507 systemd[1]: Stopped initrd-switch-root.service.
Oct 2 18:48:01.433537 kernel: audit: type=1334 audit(1696272480.824:86): prog-id=13 op=LOAD
Oct 2 18:48:01.433567 kernel: audit: type=1334 audit(1696272480.827:87): prog-id=14 op=LOAD
Oct 2 18:48:01.433597 kernel: audit: type=1334 audit(1696272480.827:88): prog-id=4 op=UNLOAD
Oct 2 18:48:01.433630 kernel: audit: type=1334 audit(1696272480.827:89): prog-id=5 op=UNLOAD
Oct 2 18:48:01.433662 kernel: audit: type=1131 audit(1696272480.829:90): 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'
Oct 2 18:48:01.433693 kernel: audit: type=1334 audit(1696272480.836:91): prog-id=12 op=UNLOAD
Oct 2 18:48:01.433723 kernel: audit: type=1130 audit(1696272480.858:92): 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'
Oct 2 18:48:01.433754 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
Oct 2 18:48:01.433786 kernel: audit: type=1131 audit(1696272480.858:93): 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'
Oct 2 18:48:01.433818 systemd[1]: Created slice system-addon\x2dconfig.slice.
Oct 2 18:48:01.433852 systemd[1]: Created slice system-addon\x2drun.slice.
Oct 2 18:48:01.433887 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice.
Oct 2 18:48:01.433917 systemd[1]: Created slice system-getty.slice.
Oct 2 18:48:01.433947 systemd[1]: Created slice system-modprobe.slice.
Oct 2 18:48:01.433977 systemd[1]: Created slice system-serial\x2dgetty.slice.
Oct 2 18:48:01.434007 systemd[1]: Created slice system-system\x2dcloudinit.slice.
Oct 2 18:48:01.434036 systemd[1]: Created slice system-systemd\x2dfsck.slice.
Oct 2 18:48:01.434068 systemd[1]: Created slice user.slice.
Oct 2 18:48:01.434109 systemd[1]: Started systemd-ask-password-console.path.
Oct 2 18:48:01.434143 systemd[1]: Started systemd-ask-password-wall.path.
Oct 2 18:48:01.434176 systemd[1]: Set up automount boot.automount.
Oct 2 18:48:01.434206 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount.
Oct 2 18:48:01.434236 systemd[1]: Stopped target initrd-switch-root.target.
Oct 2 18:48:01.434265 systemd[1]: Stopped target initrd-fs.target.
Oct 2 18:48:01.434295 systemd[1]: Stopped target initrd-root-fs.target.
Oct 2 18:48:01.434345 systemd[1]: Reached target integritysetup.target.
Oct 2 18:48:01.434379 systemd[1]: Reached target remote-cryptsetup.target.
Oct 2 18:48:01.434416 systemd[1]: Reached target remote-fs.target.
Oct 2 18:48:01.434446 systemd[1]: Reached target slices.target.
Oct 2 18:48:01.434499 systemd[1]: Reached target swap.target.
Oct 2 18:48:01.434530 systemd[1]: Reached target torcx.target.
Oct 2 18:48:01.434560 systemd[1]: Reached target veritysetup.target.
Oct 2 18:48:01.434595 systemd[1]: Listening on systemd-coredump.socket.
Oct 2 18:48:01.434626 systemd[1]: Listening on systemd-initctl.socket.
Oct 2 18:48:01.434659 systemd[1]: Listening on systemd-networkd.socket.
Oct 2 18:48:01.434692 systemd[1]: Listening on systemd-udevd-control.socket.
Oct 2 18:48:01.434721 systemd[1]: Listening on systemd-udevd-kernel.socket.
Oct 2 18:48:01.434755 systemd[1]: Listening on systemd-userdbd.socket.
Oct 2 18:48:01.434786 systemd[1]: Mounting dev-hugepages.mount...
Oct 2 18:48:01.434822 systemd[1]: Mounting dev-mqueue.mount...
Oct 2 18:48:01.434855 systemd[1]: Mounting media.mount...
Oct 2 18:48:01.434884 systemd[1]: Mounting sys-kernel-debug.mount...
Oct 2 18:48:01.434916 systemd[1]: Mounting sys-kernel-tracing.mount...
Oct 2 18:48:01.434946 systemd[1]: Mounting tmp.mount...
Oct 2 18:48:01.434977 systemd[1]: Starting flatcar-tmpfiles.service...
Oct 2 18:48:01.435009 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met.
Oct 2 18:48:01.435043 systemd[1]: Starting kmod-static-nodes.service...
Oct 2 18:48:01.435072 systemd[1]: Starting modprobe@configfs.service...
Oct 2 18:48:01.435104 systemd[1]: Starting modprobe@dm_mod.service...
Oct 2 18:48:01.435134 systemd[1]: Starting modprobe@drm.service...
Oct 2 18:48:01.435163 systemd[1]: Starting modprobe@efi_pstore.service...
Oct 2 18:48:01.435192 systemd[1]: Starting modprobe@fuse.service...
Oct 2 18:48:01.435221 systemd[1]: Starting modprobe@loop.service...
Oct 2 18:48:01.435252 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
Oct 2 18:48:01.435282 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
Oct 2 18:48:01.435315 systemd[1]: Stopped systemd-fsck-root.service.
Oct 2 18:48:01.435348 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
Oct 2 18:48:01.435377 systemd[1]: Stopped systemd-fsck-usr.service.
Oct 2 18:48:01.435407 systemd[1]: Stopped systemd-journald.service.
Oct 2 18:48:01.435438 systemd[1]: Starting systemd-journald.service...
Oct 2 18:48:01.442415 systemd[1]: Starting systemd-modules-load.service...
Oct 2 18:48:01.442861 kernel: loop: module loaded
Oct 2 18:48:01.442906 systemd[1]: Starting systemd-network-generator.service...
Oct 2 18:48:01.442941 systemd[1]: Starting systemd-remount-fs.service...
Oct 2 18:48:01.442979 systemd[1]: Starting systemd-udev-trigger.service...
Oct 2 18:48:01.443076 kernel: fuse: init (API version 7.34)
Oct 2 18:48:01.443110 systemd[1]: verity-setup.service: Deactivated successfully.
Oct 2 18:48:01.443141 systemd[1]: Stopped verity-setup.service.
Oct 2 18:48:01.443171 systemd[1]: Mounted dev-hugepages.mount.
Oct 2 18:48:01.443203 systemd[1]: Mounted dev-mqueue.mount.
Oct 2 18:48:01.443233 systemd[1]: Mounted media.mount.
Oct 2 18:48:01.443265 systemd[1]: Mounted sys-kernel-debug.mount.
Oct 2 18:48:01.443294 systemd[1]: Mounted sys-kernel-tracing.mount.
Oct 2 18:48:01.443331 systemd[1]: Mounted tmp.mount.
Oct 2 18:48:01.443392 systemd[1]: Finished kmod-static-nodes.service.
Oct 2 18:48:01.443441 systemd[1]: modprobe@configfs.service: Deactivated successfully.
Oct 2 18:48:01.443493 systemd[1]: Finished modprobe@configfs.service.
Oct 2 18:48:01.443528 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Oct 2 18:48:01.443558 systemd[1]: Finished modprobe@dm_mod.service.
Oct 2 18:48:01.443594 systemd[1]: modprobe@drm.service: Deactivated successfully.
Oct 2 18:48:01.443628 systemd[1]: Finished modprobe@drm.service.
Oct 2 18:48:01.443660 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Oct 2 18:48:01.443692 systemd[1]: Finished modprobe@efi_pstore.service.
Oct 2 18:48:01.443722 systemd[1]: modprobe@fuse.service: Deactivated successfully.
Oct 2 18:48:01.443752 systemd[1]: Finished modprobe@fuse.service.
Oct 2 18:48:01.443784 systemd[1]: modprobe@loop.service: Deactivated successfully.
Oct 2 18:48:01.443813 systemd[1]: Finished modprobe@loop.service.
Oct 2 18:48:01.443847 systemd[1]: Finished systemd-network-generator.service.
Oct 2 18:48:01.443879 systemd[1]: Finished systemd-remount-fs.service.
Oct 2 18:48:01.443911 systemd[1]: Reached target network-pre.target.
Oct 2 18:48:01.443941 systemd[1]: Mounting sys-fs-fuse-connections.mount...
Oct 2 18:48:01.443974 systemd[1]: Mounting sys-kernel-config.mount...
Oct 2 18:48:01.444009 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
Oct 2 18:48:01.444039 systemd[1]: Starting systemd-hwdb-update.service...
Oct 2 18:48:01.444070 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Oct 2 18:48:01.444099 systemd[1]: Starting systemd-random-seed.service...
Oct 2 18:48:01.444129 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met.
Oct 2 18:48:01.444159 systemd[1]: Finished systemd-modules-load.service.
Oct 2 18:48:01.444189 systemd[1]: Mounted sys-fs-fuse-connections.mount.
Oct 2 18:48:01.444219 systemd[1]: Mounted sys-kernel-config.mount.
Oct 2 18:48:01.444253 systemd[1]: Starting systemd-sysctl.service...
Oct 2 18:48:01.444291 systemd-journald[1477]: Journal started
Oct 2 18:48:01.444388 systemd-journald[1477]: Runtime Journal (/run/log/journal/ec2843d2c268a2ef9c2ffaf6ae5f28e2) is 8.0M, max 75.4M, 67.4M free.
Oct 2 18:47:56.480000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1
Oct 2 18:47:56.684000 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
Oct 2 18:47:56.684000 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
Oct 2 18:47:56.684000 audit: BPF prog-id=10 op=LOAD
Oct 2 18:47:56.684000 audit: BPF prog-id=10 op=UNLOAD
Oct 2 18:47:56.684000 audit: BPF prog-id=11 op=LOAD
Oct 2 18:47:56.684000 audit: BPF prog-id=11 op=UNLOAD
Oct 2 18:48:00.822000 audit: BPF prog-id=12 op=LOAD
Oct 2 18:48:00.822000 audit: BPF prog-id=3 op=UNLOAD
Oct 2 18:48:00.824000 audit: BPF prog-id=13 op=LOAD
Oct 2 18:48:00.827000 audit: BPF prog-id=14 op=LOAD
Oct 2 18:48:00.827000 audit: BPF prog-id=4 op=UNLOAD
Oct 2 18:48:00.827000 audit: BPF prog-id=5 op=UNLOAD
Oct 2 18:48:00.829000 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'
Oct 2 18:48:00.836000 audit: BPF prog-id=12 op=UNLOAD
Oct 2 18:48:00.858000 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'
Oct 2 18:48:00.858000 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'
Oct 2 18:48:01.146000 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'
Oct 2 18:48:01.155000 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'
Oct 2 18:48:01.159000 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'
Oct 2 18:48:01.159000 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'
Oct 2 18:48:01.161000 audit: BPF prog-id=15 op=LOAD
Oct 2 18:48:01.161000 audit: BPF prog-id=16 op=LOAD
Oct 2 18:48:01.161000 audit: BPF prog-id=17 op=LOAD
Oct 2 18:48:01.161000 audit: BPF prog-id=13 op=UNLOAD
Oct 2 18:48:01.161000 audit: BPF prog-id=14 op=UNLOAD
Oct 2 18:48:01.209000 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'
Oct 2 18:48:01.246000 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'
Oct 2 18:48:01.256000 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'
Oct 2 18:48:01.256000 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'
Oct 2 18:48:01.266000 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'
Oct 2 18:48:01.266000 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'
Oct 2 18:48:01.274000 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'
Oct 2 18:48:01.274000 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'
Oct 2 18:48:01.282000 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'
Oct 2 18:48:01.282000 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'
Oct 2 18:48:01.289000 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'
Oct 2 18:48:01.289000 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'
Oct 2 18:48:01.299000 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'
Oct 2 18:48:01.299000 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'
Oct 2 18:48:01.304000 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'
Oct 2 18:48:01.309000 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'
Oct 2 18:48:01.389000 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'
Oct 2 18:48:01.418000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1
Oct 2 18:48:01.449635 systemd[1]: Started systemd-journald.service.
Oct 2 18:48:01.418000 audit[1477]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=fffffbe42860 a2=4000 a3=1 items=0 ppid=1 pid=1477 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)
Oct 2 18:48:01.418000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald"
Oct 2 18:47:56.898752 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" 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.0 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.0 /var/lib/torcx/store]"
Oct 2 18:48:00.820128 systemd[1]: Queued start job for default target multi-user.target.
Oct 2 18:48:01.447000 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'
Oct 2 18:48:01.461000 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'
Oct 2 18:47:56.909259 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json
Oct 2 18:48:00.830654 systemd[1]: systemd-journald.service: Deactivated successfully.
Oct 2 18:47:56.909311 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json
Oct 2 18:48:01.450911 systemd[1]: Starting systemd-journal-flush.service...
Oct 2 18:47:56.909398 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12"
Oct 2 18:48:01.461270 systemd[1]: Finished systemd-random-seed.service.
Oct 2 18:47:56.909425 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=debug msg="skipped missing lower profile" missing profile=oem
Oct 2 18:48:01.463482 systemd[1]: Reached target first-boot-complete.target.
Oct 2 18:47:56.909531 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory"
Oct 2 18:47:56.909563 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)=
Oct 2 18:47:56.909977 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack
Oct 2 18:47:56.910059 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json
Oct 2 18:47:56.910095 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json
Oct 2 18:47:56.911025 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" 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
Oct 2 18:47:56.911103 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" 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
Oct 2 18:47:56.911147 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.0: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.0
Oct 2 18:47:56.911186 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store
Oct 2 18:47:56.911230 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.0: no such file or directory" path=/var/lib/torcx/store/3510.3.0
Oct 2 18:47:56.911268 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:56Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store
Oct 2 18:47:59.956854 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:59Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl
Oct 2 18:48:01.491683 systemd-journald[1477]: Time spent on flushing to /var/log/journal/ec2843d2c268a2ef9c2ffaf6ae5f28e2 is 79.511ms for 1076 entries.
Oct 2 18:48:01.491683 systemd-journald[1477]: System Journal (/var/log/journal/ec2843d2c268a2ef9c2ffaf6ae5f28e2) is 8.0M, max 195.6M, 187.6M free.
Oct 2 18:48:01.609335 systemd-journald[1477]: Received client request to flush runtime journal.
Oct 2 18:48:01.520000 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'
Oct 2 18:48:01.575000 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'
Oct 2 18:47:59.957398 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:59Z" 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
Oct 2 18:48:01.519742 systemd[1]: Finished systemd-sysctl.service.
Oct 2 18:47:59.957664 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:59Z" 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
Oct 2 18:48:01.574570 systemd[1]: Finished systemd-udev-trigger.service.
Oct 2 18:47:59.958103 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:59Z" 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
Oct 2 18:48:01.578836 systemd[1]: Starting systemd-udev-settle.service...
Oct 2 18:47:59.958206 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:59Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile=
Oct 2 18:47:59.958343 /usr/lib/systemd/system-generators/torcx-generator[1403]: time="2023-10-02T18:47:59Z" 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
Oct 2 18:48:01.612256 udevadm[1515]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in.
Oct 2 18:48:01.613000 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'
Oct 2 18:48:01.612843 systemd[1]: Finished systemd-journal-flush.service.
Oct 2 18:48:01.637800 systemd[1]: Finished flatcar-tmpfiles.service.
Oct 2 18:48:01.638000 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'
Oct 2 18:48:01.642521 systemd[1]: Starting systemd-sysusers.service...
Oct 2 18:48:01.728730 systemd[1]: Finished systemd-sysusers.service.
Oct 2 18:48:01.729000 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'
Oct 2 18:48:01.732842 systemd[1]: Starting systemd-tmpfiles-setup-dev.service...
Oct 2 18:48:01.848965 systemd[1]: Finished systemd-tmpfiles-setup-dev.service.
Oct 2 18:48:01.849000 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-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:02.365000 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'
Oct 2 18:48:02.366000 audit: BPF prog-id=18 op=LOAD
Oct 2 18:48:02.366000 audit: BPF prog-id=19 op=LOAD
Oct 2 18:48:02.366000 audit: BPF prog-id=7 op=UNLOAD
Oct 2 18:48:02.366000 audit: BPF prog-id=8 op=UNLOAD
Oct 2 18:48:02.364949 systemd[1]: Finished systemd-hwdb-update.service.
Oct 2 18:48:02.369115 systemd[1]: Starting systemd-udevd.service...
Oct 2 18:48:02.417532 systemd-udevd[1525]: Using default interface naming scheme 'v252'.
Oct 2 18:48:02.457756 systemd[1]: Started systemd-udevd.service.
Oct 2 18:48:02.458000 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'
Oct 2 18:48:02.459000 audit: BPF prog-id=20 op=LOAD
Oct 2 18:48:02.462673 systemd[1]: Starting systemd-networkd.service...
Oct 2 18:48:02.486000 audit: BPF prog-id=21 op=LOAD
Oct 2 18:48:02.486000 audit: BPF prog-id=22 op=LOAD
Oct 2 18:48:02.487000 audit: BPF prog-id=23 op=LOAD
Oct 2 18:48:02.490910 systemd[1]: Starting systemd-userdbd.service...
Oct 2 18:48:02.609263 systemd[1]: Started systemd-userdbd.service.
Oct 2 18:48:02.609000 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'
Oct 2 18:48:02.619292 systemd[1]: Condition check resulted in dev-ttyS0.device being skipped.
Oct 2 18:48:02.671398 (udev-worker)[1539]: Network interface NamePolicy= disabled on kernel command line.
Oct 2 18:48:02.802845 systemd-networkd[1531]: lo: Link UP
Oct 2 18:48:02.802869 systemd-networkd[1531]: lo: Gained carrier
Oct 2 18:48:02.803791 systemd-networkd[1531]: Enumeration completed
Oct 2 18:48:02.803962 systemd[1]: Started systemd-networkd.service.
Oct 2 18:48:02.808075 systemd[1]: Starting systemd-networkd-wait-online.service...
Oct 2 18:48:02.804000 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'
Oct 2 18:48:02.813692 systemd-networkd[1531]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Oct 2 18:48:02.818496 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Oct 2 18:48:02.819211 systemd-networkd[1531]: eth0: Link UP
Oct 2 18:48:02.819810 systemd-networkd[1531]: eth0: Gained carrier
Oct 2 18:48:02.849807 systemd-networkd[1531]: eth0: DHCPv4 address 172.31.19.37/20, gateway 172.31.16.1 acquired from 172.31.16.1
Oct 2 18:48:02.931491 kernel: BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/nvme0n1p6 scanned by (udev-worker) (1536)
Oct 2 18:48:03.145084 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device.
Oct 2 18:48:03.148494 systemd[1]: Finished systemd-udev-settle.service.
Oct 2 18:48:03.149000 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'
Oct 2 18:48:03.153006 systemd[1]: Starting lvm2-activation-early.service...
Oct 2 18:48:03.177880 lvm[1644]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Oct 2 18:48:03.213491 systemd[1]: Finished lvm2-activation-early.service.
Oct 2 18:48:03.214000 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'
Oct 2 18:48:03.215681 systemd[1]: Reached target cryptsetup.target.
Oct 2 18:48:03.219803 systemd[1]: Starting lvm2-activation.service...
Oct 2 18:48:03.234761 lvm[1645]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Oct 2 18:48:03.269550 systemd[1]: Finished lvm2-activation.service.
Oct 2 18:48:03.270000 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'
Oct 2 18:48:03.271639 systemd[1]: Reached target local-fs-pre.target.
Oct 2 18:48:03.273541 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw).
Oct 2 18:48:03.273595 systemd[1]: Reached target local-fs.target.
Oct 2 18:48:03.275310 systemd[1]: Reached target machines.target.
Oct 2 18:48:03.279121 systemd[1]: Starting ldconfig.service...
Oct 2 18:48:03.283441 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met.
Oct 2 18:48:03.283590 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).
Oct 2 18:48:03.286409 systemd[1]: Starting systemd-boot-update.service...
Oct 2 18:48:03.290371 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service...
Oct 2 18:48:03.297615 systemd[1]: Starting systemd-machine-id-commit.service...
Oct 2 18:48:03.299745 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met.
Oct 2 18:48:03.299870 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met.
Oct 2 18:48:03.302641 systemd[1]: Starting systemd-tmpfiles-setup.service...
Oct 2 18:48:03.338729 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1647 (bootctl)
Oct 2 18:48:03.341054 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service...
Oct 2 18:48:03.372587 systemd-tmpfiles[1650]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring.
Oct 2 18:48:03.375591 systemd-tmpfiles[1650]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
Oct 2 18:48:03.380296 systemd-tmpfiles[1650]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
Oct 2 18:48:03.384145 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
Oct 2 18:48:03.388159 systemd[1]: Finished systemd-machine-id-commit.service.
Oct 2 18:48:03.389000 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'
Oct 2 18:48:03.399694 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service.
Oct 2 18:48:03.400000 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'
Oct 2 18:48:03.459944 systemd-fsck[1655]: fsck.fat 4.2 (2021-01-31)
Oct 2 18:48:03.459944 systemd-fsck[1655]: /dev/nvme0n1p1: 236 files, 113463/258078 clusters
Oct 2 18:48:03.465677 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service.
Oct 2 18:48:03.466000 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'
Oct 2 18:48:03.470893 systemd[1]: Mounting boot.mount...
Oct 2 18:48:03.508007 systemd[1]: Mounted boot.mount.
Oct 2 18:48:03.540011 systemd[1]: Finished systemd-boot-update.service.
Oct 2 18:48:03.540000 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'
Oct 2 18:48:03.727070 systemd[1]: Finished systemd-tmpfiles-setup.service.
Oct 2 18:48:03.728000 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'
Oct 2 18:48:03.731844 systemd[1]: Starting audit-rules.service...
Oct 2 18:48:03.743000 audit: BPF prog-id=24 op=LOAD
Oct 2 18:48:03.736015 systemd[1]: Starting clean-ca-certificates.service...
Oct 2 18:48:03.741508 systemd[1]: Starting systemd-journal-catalog-update.service...
Oct 2 18:48:03.748475 systemd[1]: Starting systemd-resolved.service...
Oct 2 18:48:03.750000 audit: BPF prog-id=25 op=LOAD
Oct 2 18:48:03.757950 systemd[1]: Starting systemd-timesyncd.service...
Oct 2 18:48:03.761979 systemd[1]: Starting systemd-update-utmp.service...
Oct 2 18:48:03.806513 systemd[1]: Finished clean-ca-certificates.service.
Oct 2 18:48:03.808773 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt).
Oct 2 18:48:03.807000 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'
Oct 2 18:48:03.819000 audit[1675]: SYSTEM_BOOT pid=1675 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'
Oct 2 18:48:03.830333 systemd[1]: Finished systemd-update-utmp.service.
Oct 2 18:48:03.831000 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'
Oct 2 18:48:03.897038 systemd[1]: Finished systemd-journal-catalog-update.service.
Oct 2 18:48:03.898000 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'
Oct 2 18:48:03.964109 systemd[1]: Started systemd-timesyncd.service.
Oct 2 18:48:03.966357 systemd[1]: Reached target time-set.target.
Oct 2 18:48:03.965000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-timesyncd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:03.989781 systemd-resolved[1673]: Positive Trust Anchors:
Oct 2 18:48:03.990641 systemd-resolved[1673]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Oct 2 18:48:03.990835 systemd-resolved[1673]: 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
Oct 2 18:48:03.995000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1
Oct 2 18:48:03.995000 audit[1691]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffdf560af0 a2=420 a3=0 items=0 ppid=1670 pid=1691 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)
Oct 2 18:48:03.995000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573
Oct 2 18:48:03.997732 augenrules[1691]: No rules
Oct 2 18:48:03.999509 systemd[1]: Finished audit-rules.service.
Oct 2 18:48:04.019271 systemd-timesyncd[1674]: Contacted time server 167.248.62.201:123 (0.flatcar.pool.ntp.org).
Oct 2 18:48:04.020031 systemd-timesyncd[1674]: Initial clock synchronization to Mon 2023-10-02 18:48:03.785007 UTC.
Oct 2 18:48:04.026187 systemd-resolved[1673]: Defaulting to hostname 'linux'.
Oct 2 18:48:04.030202 systemd[1]: Started systemd-resolved.service.
Oct 2 18:48:04.032152 systemd[1]: Reached target network.target.
Oct 2 18:48:04.033934 systemd[1]: Reached target nss-lookup.target.
Oct 2 18:48:04.158399 ldconfig[1646]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
Oct 2 18:48:04.175081 systemd[1]: Finished ldconfig.service.
Oct 2 18:48:04.179118 systemd[1]: Starting systemd-update-done.service...
Oct 2 18:48:04.201450 systemd[1]: Finished systemd-update-done.service.
Oct 2 18:48:04.203623 systemd[1]: Reached target sysinit.target.
Oct 2 18:48:04.205567 systemd[1]: Started motdgen.path.
Oct 2 18:48:04.207149 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path.
Oct 2 18:48:04.209753 systemd[1]: Started logrotate.timer.
Oct 2 18:48:04.211649 systemd[1]: Started mdadm.timer.
Oct 2 18:48:04.213128 systemd[1]: Started systemd-tmpfiles-clean.timer.
Oct 2 18:48:04.214908 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
Oct 2 18:48:04.214960 systemd[1]: Reached target paths.target.
Oct 2 18:48:04.216478 systemd[1]: Reached target timers.target.
Oct 2 18:48:04.218443 systemd[1]: Listening on dbus.socket.
Oct 2 18:48:04.221777 systemd[1]: Starting docker.socket...
Oct 2 18:48:04.232488 systemd[1]: Listening on sshd.socket.
Oct 2 18:48:04.234346 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).
Oct 2 18:48:04.235183 systemd[1]: Listening on docker.socket.
Oct 2 18:48:04.237058 systemd[1]: Reached target sockets.target.
Oct 2 18:48:04.238763 systemd[1]: Reached target basic.target.
Oct 2 18:48:04.240415 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met.
Oct 2 18:48:04.240508 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met.
Oct 2 18:48:04.242662 systemd[1]: Starting containerd.service...
Oct 2 18:48:04.246198 systemd[1]: Starting coreos-metadata-sshkeys@core.service...
Oct 2 18:48:04.254091 systemd[1]: Starting dbus.service...
Oct 2 18:48:04.258974 systemd[1]: Starting enable-oem-cloudinit.service...
Oct 2 18:48:04.262939 systemd[1]: Starting extend-filesystems.service...
Oct 2 18:48:04.264721 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment).
Oct 2 18:48:04.267144 systemd[1]: Starting motdgen.service...
Oct 2 18:48:04.271956 systemd[1]: Starting ssh-key-proc-cmdline.service...
Oct 2 18:48:04.275999 systemd[1]: Starting sshd-keygen.service...
Oct 2 18:48:04.283907 systemd[1]: Starting systemd-logind.service...
Oct 2 18:48:04.286701 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f).
Oct 2 18:48:04.286851 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
Oct 2 18:48:04.287739 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
Oct 2 18:48:04.289340 systemd[1]: Starting update-engine.service...
Oct 2 18:48:04.293902 systemd[1]: Starting update-ssh-keys-after-ignition.service...
Oct 2 18:48:04.310355 systemd[1]: Created slice system-sshd.slice.
Oct 2 18:48:04.344768 jq[1709]: false
Oct 2 18:48:04.351707 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'.
Oct 2 18:48:04.352070 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service being skipped.
Oct 2 18:48:04.364255 jq[1702]: true
Oct 2 18:48:04.381887 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
Oct 2 18:48:04.382283 systemd[1]: Finished ssh-key-proc-cmdline.service.
Oct 2 18:48:04.385120 dbus-daemon[1701]: [system] SELinux support is enabled
Oct 2 18:48:04.385391 systemd[1]: Started dbus.service.
Oct 2 18:48:04.390693 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).
Oct 2 18:48:04.390759 systemd[1]: Reached target system-config.target.
Oct 2 18:48:04.392752 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url).
Oct 2 18:48:04.392815 systemd[1]: Reached target user-config.target.
Oct 2 18:48:04.402135 dbus-daemon[1701]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1531 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0")
Oct 2 18:48:04.411878 dbus-daemon[1701]: [system] Successfully activated service 'org.freedesktop.systemd1'
Oct 2 18:48:04.417849 systemd[1]: Starting systemd-hostnamed.service...
Oct 2 18:48:04.431134 jq[1718]: true
Oct 2 18:48:04.505219 systemctl[1729]: Created symlink /etc/systemd/system/multi-user.target.wants/oem-cloudinit.service → /usr/lib/systemd/system/oem-cloudinit.service.
Oct 2 18:48:04.505308 systemd[1]: Reloading.
Oct 2 18:48:04.533852 extend-filesystems[1703]: Found nvme0n1
Oct 2 18:48:04.533852 extend-filesystems[1703]: Found nvme0n1p1
Oct 2 18:48:04.537680 extend-filesystems[1703]: Found nvme0n1p2
Oct 2 18:48:04.537680 extend-filesystems[1703]: Found nvme0n1p3
Oct 2 18:48:04.537680 extend-filesystems[1703]: Found usr
Oct 2 18:48:04.537680 extend-filesystems[1703]: Found nvme0n1p4
Oct 2 18:48:04.537680 extend-filesystems[1703]: Found nvme0n1p6
Oct 2 18:48:04.537680 extend-filesystems[1703]: Found nvme0n1p7
Oct 2 18:48:04.547671 extend-filesystems[1703]: Found nvme0n1p9
Oct 2 18:48:04.547671 extend-filesystems[1703]: Checking size of /dev/nvme0n1p9
Oct 2 18:48:04.583940 update_engine[1708]: I1002 18:48:04.583518 1708 main.cc:92] Flatcar Update Engine starting
Oct 2 18:48:04.587800 systemd-networkd[1531]: eth0: Gained IPv6LL
Oct 2 18:48:04.620519 update_engine[1708]: I1002 18:48:04.620296 1708 update_check_scheduler.cc:74] Next update check in 5m3s
Oct 2 18:48:04.718609 extend-filesystems[1703]: Resized partition /dev/nvme0n1p9
Oct 2 18:48:04.761674 extend-filesystems[1761]: resize2fs 1.46.5 (30-Dec-2021)
Oct 2 18:48:04.794536 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks
Oct 2 18:48:04.813555 /usr/lib/systemd/system-generators/torcx-generator[1755]: time="2023-10-02T18:48:04Z" 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.0 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.0 /var/lib/torcx/store]"
Oct 2 18:48:04.813616 /usr/lib/systemd/system-generators/torcx-generator[1755]: time="2023-10-02T18:48:04Z" level=info msg="torcx already run"
Oct 2 18:48:04.824373 systemd-logind[1707]: Watching system buttons on /dev/input/event0 (Power Button)
Oct 2 18:48:04.841878 systemd-logind[1707]: New seat seat0.
Oct 2 18:48:04.865143 env[1712]: time="2023-10-02T18:48:04.865064581Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16
Oct 2 18:48:04.897689 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915
Oct 2 18:48:04.927737 extend-filesystems[1761]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required
Oct 2 18:48:04.927737 extend-filesystems[1761]: old_desc_blocks = 1, new_desc_blocks = 1
Oct 2 18:48:04.927737 extend-filesystems[1761]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long.
Oct 2 18:48:04.953278 extend-filesystems[1703]: Resized filesystem in /dev/nvme0n1p9
Oct 2 18:48:04.946898 dbus-daemon[1701]: [system] Successfully activated service 'org.freedesktop.hostname1'
Oct 2 18:48:04.947536 dbus-daemon[1701]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1727 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0")
Oct 2 18:48:05.029828 env[1712]: time="2023-10-02T18:48:05.029582318Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Oct 2 18:48:05.030214 env[1712]: time="2023-10-02T18:48:05.030174502Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Oct 2 18:48:05.038663 env[1712]: time="2023-10-02T18:48:05.038591560Z" 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.132-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Oct 2 18:48:05.038879 env[1712]: time="2023-10-02T18:48:05.038846100Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Oct 2 18:48:05.039423 env[1712]: time="2023-10-02T18:48:05.039369998Z" 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
Oct 2 18:48:05.039667 env[1712]: time="2023-10-02T18:48:05.039629466Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Oct 2 18:48:05.039920 env[1712]: time="2023-10-02T18:48:05.039880931Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured"
Oct 2 18:48:05.040062 env[1712]: time="2023-10-02T18:48:05.040028056Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Oct 2 18:48:05.040382 env[1712]: time="2023-10-02T18:48:05.040344254Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Oct 2 18:48:05.041307 env[1712]: time="2023-10-02T18:48:05.041255712Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Oct 2 18:48:05.049642 env[1712]: time="2023-10-02T18:48:05.049565727Z" 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
Oct 2 18:48:05.049844 env[1712]: time="2023-10-02T18:48:05.049812707Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Oct 2 18:48:05.050176 env[1712]: time="2023-10-02T18:48:05.050142150Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured"
Oct 2 18:48:05.050328 env[1712]: time="2023-10-02T18:48:05.050300505Z" level=info msg="metadata content store policy set" policy=shared
Oct 2 18:48:05.057531 env[1712]: time="2023-10-02T18:48:05.057208610Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Oct 2 18:48:05.057531 env[1712]: time="2023-10-02T18:48:05.057273844Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Oct 2 18:48:05.057531 env[1712]: time="2023-10-02T18:48:05.057307370Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Oct 2 18:48:05.057531 env[1712]: time="2023-10-02T18:48:05.057384031Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Oct 2 18:48:05.059335 env[1712]: time="2023-10-02T18:48:05.057417487Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Oct 2 18:48:05.059335 env[1712]: time="2023-10-02T18:48:05.058007586Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Oct 2 18:48:05.059335 env[1712]: time="2023-10-02T18:48:05.058045177Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Oct 2 18:48:05.059335 env[1712]: time="2023-10-02T18:48:05.058637943Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Oct 2 18:48:05.059335 env[1712]: time="2023-10-02T18:48:05.058683478Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1
Oct 2 18:48:05.059335 env[1712]: time="2023-10-02T18:48:05.058718146Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Oct 2 18:48:05.059335 env[1712]: time="2023-10-02T18:48:05.058750844Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Oct 2 18:48:05.059335 env[1712]: time="2023-10-02T18:48:05.058780782Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Oct 2 18:48:05.059335 env[1712]: time="2023-10-02T18:48:05.059010731Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Oct 2 18:48:05.059335 env[1712]: time="2023-10-02T18:48:05.059204383Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Oct 2 18:48:05.060643 env[1712]: time="2023-10-02T18:48:05.060594645Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Oct 2 18:48:05.060840 env[1712]: time="2023-10-02T18:48:05.060810604Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.060963 env[1712]: time="2023-10-02T18:48:05.060934432Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Oct 2 18:48:05.061247 env[1712]: time="2023-10-02T18:48:05.061218525Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.061752 env[1712]: time="2023-10-02T18:48:05.061720710Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.061874 env[1712]: time="2023-10-02T18:48:05.061846436Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.062009 env[1712]: time="2023-10-02T18:48:05.061980853Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.062125 env[1712]: time="2023-10-02T18:48:05.062097435Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.062287 env[1712]: time="2023-10-02T18:48:05.062259157Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.062405 env[1712]: time="2023-10-02T18:48:05.062376520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.062566 env[1712]: time="2023-10-02T18:48:05.062536844Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.062740 env[1712]: time="2023-10-02T18:48:05.062706615Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Oct 2 18:48:05.063172 env[1712]: time="2023-10-02T18:48:05.063126861Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.063332 env[1712]: time="2023-10-02T18:48:05.063302550Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.063489 env[1712]: time="2023-10-02T18:48:05.063442453Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.063619 env[1712]: time="2023-10-02T18:48:05.063588938Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Oct 2 18:48:05.063759 env[1712]: time="2023-10-02T18:48:05.063723949Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1
Oct 2 18:48:05.063901 env[1712]: time="2023-10-02T18:48:05.063872973Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Oct 2 18:48:05.064033 env[1712]: time="2023-10-02T18:48:05.064000098Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin"
Oct 2 18:48:05.064195 env[1712]: time="2023-10-02T18:48:05.064166456Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
Oct 2 18:48:05.064795 env[1712]: time="2023-10-02T18:48:05.064684145Z" 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}"
Oct 2 18:48:05.068690 env[1712]: time="2023-10-02T18:48:05.065406074Z" level=info msg="Connect containerd service"
Oct 2 18:48:05.069032 env[1712]: time="2023-10-02T18:48:05.068987892Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
Oct 2 18:48:05.071646 env[1712]: time="2023-10-02T18:48:05.071588254Z" 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"
Oct 2 18:48:05.072478 env[1712]: time="2023-10-02T18:48:05.072412240Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
Oct 2 18:48:05.074702 env[1712]: time="2023-10-02T18:48:05.074637752Z" level=info msg=serving... address=/run/containerd/containerd.sock
Oct 2 18:48:05.074993 env[1712]: time="2023-10-02T18:48:05.074958959Z" level=info msg="containerd successfully booted in 0.240914s"
Oct 2 18:48:05.076535 env[1712]: time="2023-10-02T18:48:05.076444078Z" level=info msg="Start subscribing containerd event"
Oct 2 18:48:05.102829 env[1712]: time="2023-10-02T18:48:05.102757398Z" level=info msg="Start recovering state"
Oct 2 18:48:05.102969 env[1712]: time="2023-10-02T18:48:05.102921135Z" level=info msg="Start event monitor"
Oct 2 18:48:05.103106 env[1712]: time="2023-10-02T18:48:05.103067213Z" level=info msg="Start snapshots syncer"
Oct 2 18:48:05.103173 env[1712]: time="2023-10-02T18:48:05.103102975Z" level=info msg="Start cni network conf syncer for default"
Oct 2 18:48:05.103173 env[1712]: time="2023-10-02T18:48:05.103127938Z" level=info msg="Start streaming server"
Oct 2 18:48:05.212535 coreos-metadata[1700]: Oct 02 18:48:05.211 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1
Oct 2 18:48:05.221670 coreos-metadata[1700]: Oct 02 18:48:05.221 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys: Attempt #1
Oct 2 18:48:05.221670 coreos-metadata[1700]: Oct 02 18:48:05.221 INFO Fetch successful
Oct 2 18:48:05.221670 coreos-metadata[1700]: Oct 02 18:48:05.221 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys/0/openssh-key: Attempt #1
Oct 2 18:48:05.221670 coreos-metadata[1700]: Oct 02 18:48:05.221 INFO Fetch successful
Oct 2 18:48:05.224446 unknown[1700]: wrote ssh authorized keys file for user: core
Oct 2 18:48:05.308215 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon.
Oct 2 18:48:05.308250 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon.
Oct 2 18:48:05.362590 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.
Oct 2 18:48:05.550416 systemd[1]: Started containerd.service.
Oct 2 18:48:05.553363 systemd[1]: Finished systemd-networkd-wait-online.service.
Oct 2 18:48:05.557911 systemd[1]: extend-filesystems.service: Deactivated successfully.
Oct 2 18:48:05.558309 systemd[1]: Finished extend-filesystems.service.
Oct 2 18:48:05.561294 systemd[1]: motdgen.service: Deactivated successfully.
Oct 2 18:48:05.561694 systemd[1]: Finished motdgen.service.
Oct 2 18:48:05.576135 systemd[1]: Started update-engine.service.
Oct 2 18:48:05.578659 systemd[1]: Started systemd-logind.service.
Oct 2 18:48:05.581153 systemd[1]: Started systemd-hostnamed.service.
Oct 2 18:48:05.584887 systemd[1]: Reached target network-online.target.
Oct 2 18:48:05.591181 systemd[1]: Started amazon-ssm-agent.service.
Oct 2 18:48:05.630639 systemd[1]: Started locksmithd.service.
Oct 2 18:48:05.644681 systemd[1]: Started nvidia.service.
Oct 2 18:48:05.646203 update-ssh-keys[1902]: Updated "/home/core/.ssh/authorized_keys"
Oct 2 18:48:05.656641 systemd[1]: Starting oem-cloudinit.service...
Oct 2 18:48:05.661059 systemd[1]: Starting polkit.service...
Oct 2 18:48:05.679585 systemd[1]: Finished coreos-metadata-sshkeys@core.service.
Oct 2 18:48:05.694871 bash[1907]: + OEMS=(aws gcp rackspace-onmetal azure cloudsigma packet vmware digitalocean openstack)
Oct 2 18:48:05.697606 bash[1911]: + grep -q -x -F aws
Oct 2 18:48:05.726755 bash[1910]: + tr ' ' '
Oct 2 18:48:05.726755 bash[1910]: '
Oct 2 18:48:05.732326 bash[1909]: + echo aws gcp rackspace-onmetal azure cloudsigma packet vmware digitalocean openstack
Oct 2 18:48:05.849698 polkitd[1908]: Started polkitd version 121
Oct 2 18:48:05.893689 bash[1919]: ++ '[' aws = aws -o aws = openstack ']'
Oct 2 18:48:05.894372 bash[1919]: ++ echo ec2-compat
Oct 2 18:48:05.900039 bash[1917]: + /usr/bin/coreos-cloudinit --oem=ec2-compat
Oct 2 18:48:05.915579 polkitd[1908]: Loading rules from directory /etc/polkit-1/rules.d
Oct 2 18:48:05.916823 polkitd[1908]: Loading rules from directory /usr/share/polkit-1/rules.d
Oct 2 18:48:05.921238 polkitd[1908]: Finished loading, compiling and executing 2 rules
Oct 2 18:48:05.922168 dbus-daemon[1701]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Oct 2 18:48:05.922422 systemd[1]: Started polkit.service.
Oct 2 18:48:05.925171 polkitd[1908]: Acquired the name org.freedesktop.PolicyKit1 on the system bus
Oct 2 18:48:05.956948 amazon-ssm-agent[1903]: 2023/10/02 18:48:05 Failed to load instance info from vault. RegistrationKey does not exist.
Oct 2 18:48:05.958356 systemd-hostnamed[1727]: Hostname set to <ip-172-31-19-37> (transient)
Oct 2 18:48:05.958795 systemd-resolved[1673]: System hostname changed to 'ip-172-31-19-37'.
Oct 2 18:48:05.970420 amazon-ssm-agent[1903]: Initializing new seelog logger
Oct 2 18:48:05.971687 amazon-ssm-agent[1903]: New Seelog Logger Creation Complete
Oct 2 18:48:05.972771 amazon-ssm-agent[1903]: 2023/10/02 18:48:05 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json.
Oct 2 18:48:05.972891 amazon-ssm-agent[1903]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json.
Oct 2 18:48:05.973474 amazon-ssm-agent[1903]: 2023/10/02 18:48:05 processing appconfig overrides
Oct 2 18:48:06.026680 systemd[1]: nvidia.service: Deactivated successfully.
Oct 2 18:48:06.295931 bash[1917]: 2023/10/02 18:48:06 fetching token...
Oct 2 18:48:06.298771 bash[1917]: 2023/10/02 18:48:06 Checking availability of "cloud-drive"
Oct 2 18:48:06.298771 bash[1917]: 2023/10/02 18:48:06 Checking availability of "ec2-metadata-service"
Oct 2 18:48:06.300199 bash[1917]: 2023/10/02 18:48:06 Fetching user-data from datasource of type "ec2-metadata-service"
Oct 2 18:48:06.300400 bash[1917]: 2023/10/02 18:48:06 Fetching data from http://169.254.169.254/2009-04-04/user-data. Attempt #1
Oct 2 18:48:06.331249 bash[1917]: 2023/10/02 18:48:06 line 17: warning: discovery URL is not valid
Oct 2 18:48:06.331249 bash[1917]: 2023/10/02 18:48:06 line 56: warning: deprecated key "etcd2" (etcd2 is no longer shipped in Container Linux)
Oct 2 18:48:06.331249 bash[1917]: 2023/10/02 18:48:06 line 58: warning: deprecated key "ca_file" (ca_file obsoleted by trusted_ca_file and client_cert_auth)
Oct 2 18:48:06.331249 bash[1917]: 2023/10/02 18:48:06 line 83: warning: deprecated key "peer_ca_file" (peer_ca_file obsoleted peer_trusted_ca_file and peer_client_cert_auth)
Oct 2 18:48:06.331249 bash[1917]: 2023/10/02 18:48:06 line 108: warning: deprecated key "fleet" (fleet is no longer shipped in Container Linux)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 6: warning: deprecated key "etcd" (etcd is no longer shipped in Container Linux)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 48: warning: deprecated key "proxy" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 29: warning: deprecated key "initial_cluster_state" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 30: warning: deprecated key "initial_cluster_token" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 20: warning: deprecated key "discovery_proxy" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 19: warning: deprecated key "discovery_srv" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 21: warning: deprecated key "election_timeout" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 33: warning: deprecated key "listen_peer_urls" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 8: warning: deprecated key "advertise_client_urls" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 27: warning: deprecated key "initial_advertise_peer_urls" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 36: warning: deprecated key "max_snapshots" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 18: warning: deprecated key "discovery_fallback" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 24: warning: deprecated key "heartbeat_interval" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 28: warning: deprecated key "initial_cluster" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 22: warning: deprecated key "force_new_cluster" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 32: warning: deprecated key "listen_client_urls" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 line 37: warning: deprecated key "max_wals" (etcd2 options no longer work for etcd)
Oct 2 18:48:06.331757 bash[1917]: 2023/10/02 18:48:06 Fetching meta-data from datasource of type "ec2-metadata-service"
Oct 2 18:48:06.332950 bash[1917]: 2023/10/02 18:48:06 Fetching data from http://169.254.169.254/2009-04-04/meta-data/public-keys. Attempt #1
Oct 2 18:48:06.332950 bash[1917]: 2023/10/02 18:48:06 Fetching data from http://169.254.169.254/2009-04-04/meta-data/public-keys/0/openssh-key. Attempt #1
Oct 2 18:48:06.333137 bash[1917]: 2023/10/02 18:48:06 Found SSH key for "ci-3510.3.0-arm64-e84cea3e-3662-4585-8d4d-36bdf13b4682"
Oct 2 18:48:06.333137 bash[1917]: 2023/10/02 18:48:06 Fetching data from http://169.254.169.254/2009-04-04/meta-data/hostname. Attempt #1
Oct 2 18:48:06.333941 bash[1917]: 2023/10/02 18:48:06 Fetching data from http://169.254.169.254/2009-04-04/meta-data/local-ipv4. Attempt #1
Oct 2 18:48:06.334869 bash[1917]: 2023/10/02 18:48:06 Fetching data from http://169.254.169.254/2009-04-04/meta-data/public-ipv4. Attempt #1
Oct 2 18:48:06.338414 bash[1917]: 2023/10/02 18:48:06 Parsing user-data as cloud-config
Oct 2 18:48:06.339036 bash[1917]: 2023/10/02 18:48:06 Merging cloud-config from meta-data and user-data
Oct 2 18:48:06.339036 bash[1917]: 2023/10/02 18:48:06 Warning: user-data hostname (core1) overrides metadata hostname (ip-172-31-19-37.us-west-2.compute.internal)
Oct 2 18:48:06.349723 amazon-ssm-agent[1903]: 2023-10-02 18:48:06 INFO Agent is in hibernate mode. Reducing logging. Logging will be reduced to one log per backoff period
Oct 2 18:48:06.350131 amazon-ssm-agent[1903]: 2023-10-02 18:48:06 INFO Entering SSM Agent hibernate - AccessDeniedException: User: arn:aws:sts::075585003325:assumed-role/jenkins-test/i-02a03307e6d9bd209 is not authorized to perform: ssm:UpdateInstanceInformation on resource: arn:aws:ec2:us-west-2:075585003325:instance/i-02a03307e6d9bd209 because no identity-based policy allows the ssm:UpdateInstanceInformation action
Oct 2 18:48:06.350131 amazon-ssm-agent[1903]: status code: 400, request id: 0105ccdd-bf64-4787-a226-0738cce40f09
Oct 2 18:48:06.357610 systemd-resolved[1673]: System hostname changed to 'core1'.
Oct 2 18:48:06.357611 systemd-hostnamed[1727]: Hostname set to <core1> (static)
Oct 2 18:48:06.360905 bash[1917]: 2023/10/02 18:48:06 Set hostname to core1
Oct 2 18:48:06.373704 bash[1917]: 2023/10/02 18:48:06 Authorized SSH keys for core user
Oct 2 18:48:06.373853 bash[1917]: 2023/10/02 18:48:06 Writing file to "/foo"
Oct 2 18:48:06.373998 bash[1917]: 2023/10/02 18:48:06 Wrote file to "/foo"
Oct 2 18:48:06.373998 bash[1917]: 2023/10/02 18:48:06 Wrote file /foo to filesystem
Oct 2 18:48:06.374130 bash[1917]: 2023/10/02 18:48:06 Writing file to "/etc/environment"
Oct 2 18:48:06.374550 bash[1917]: 2023/10/02 18:48:06 Wrote file to "/etc/environment"
Oct 2 18:48:06.374550 bash[1917]: 2023/10/02 18:48:06 Updated /etc/environment
Oct 2 18:48:06.374550 bash[1917]: 2023/10/02 18:48:06 Ensuring runtime unit file "etcd.service" is unmasked
Oct 2 18:48:06.374550 bash[1917]: 2023/10/02 18:48:06 Ensuring runtime unit file "etcd2.service" is unmasked
Oct 2 18:48:06.374550 bash[1917]: 2023/10/02 18:48:06 Ensuring runtime unit file "fleet.service" is unmasked
Oct 2 18:48:06.374550 bash[1917]: 2023/10/02 18:48:06 Ensuring runtime unit file "locksmithd.service" is unmasked
Oct 2 18:48:06.376195 systemd[1]: oem-cloudinit.service: Deactivated successfully.
Oct 2 18:48:06.376553 systemd[1]: Finished oem-cloudinit.service.
Oct 2 18:48:06.381604 systemd[1]: Finished enable-oem-cloudinit.service.
Oct 2 18:48:06.391795 locksmithd[1904]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
Oct 2 18:48:09.379842 sshd_keygen[1728]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
Oct 2 18:48:09.440550 systemd[1]: Finished sshd-keygen.service.
Oct 2 18:48:09.446312 systemd[1]: Starting issuegen.service...
Oct 2 18:48:09.450427 systemd[1]: Started sshd@0-172.31.19.37:22-139.178.89.65:33634.service.
Oct 2 18:48:09.470042 systemd[1]: issuegen.service: Deactivated successfully.
Oct 2 18:48:09.470393 systemd[1]: Finished issuegen.service.
Oct 2 18:48:09.475980 systemd[1]: Starting systemd-user-sessions.service...
Oct 2 18:48:09.500535 systemd[1]: Finished systemd-user-sessions.service.
Oct 2 18:48:09.507499 systemd[1]: Started getty@tty1.service.
Oct 2 18:48:09.514009 systemd[1]: Started serial-getty@ttyS0.service.
Oct 2 18:48:09.517904 systemd[1]: Reached target getty.target.
Oct 2 18:48:09.519784 systemd[1]: Reached target multi-user.target.
Oct 2 18:48:09.524298 systemd[1]: Starting systemd-update-utmp-runlevel.service...
Oct 2 18:48:09.551749 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully.
Oct 2 18:48:09.552109 systemd[1]: Finished systemd-update-utmp-runlevel.service.
Oct 2 18:48:09.554513 systemd[1]: Startup finished in 1.198s (kernel) + 7.737s (initrd) + 13.214s (userspace) = 22.150s.
Oct 2 18:48:09.702780 sshd[1968]: Accepted publickey for core from 139.178.89.65 port 33634 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8
Oct 2 18:48:09.707404 sshd[1968]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 18:48:09.725549 systemd[1]: Created slice user-500.slice.
Oct 2 18:48:09.728731 systemd[1]: Starting user-runtime-dir@500.service...
Oct 2 18:48:09.735338 systemd-logind[1707]: New session 1 of user core.
Oct 2 18:48:09.753661 systemd[1]: Finished user-runtime-dir@500.service.
Oct 2 18:48:09.758345 systemd[1]: Starting user@500.service...
Oct 2 18:48:09.770243 (systemd)[1977]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
Oct 2 18:48:09.979993 systemd[1977]: Queued start job for default target default.target.
Oct 2 18:48:09.982143 systemd[1977]: Reached target paths.target.
Oct 2 18:48:09.982351 systemd[1977]: Reached target sockets.target.
Oct 2 18:48:09.982553 systemd[1977]: Reached target timers.target.
Oct 2 18:48:09.982704 systemd[1977]: Reached target basic.target.
Oct 2 18:48:09.982937 systemd[1977]: Reached target default.target.
Oct 2 18:48:09.983033 systemd[1]: Started user@500.service.
Oct 2 18:48:09.984500 systemd[1977]: Startup finished in 196ms.
Oct 2 18:48:09.985013 systemd[1]: Started session-1.scope.
Oct 2 18:48:10.137198 systemd[1]: Started sshd@1-172.31.19.37:22-139.178.89.65:47040.service.
Oct 2 18:48:10.317997 sshd[1986]: Accepted publickey for core from 139.178.89.65 port 47040 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8
Oct 2 18:48:10.321231 sshd[1986]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 18:48:10.330729 systemd[1]: Started session-2.scope.
Oct 2 18:48:10.331862 systemd-logind[1707]: New session 2 of user core.
Oct 2 18:48:10.476698 sshd[1986]: pam_unix(sshd:session): session closed for user core
Oct 2 18:48:10.482520 systemd-logind[1707]: Session 2 logged out. Waiting for processes to exit.
Oct 2 18:48:10.483086 systemd[1]: sshd@1-172.31.19.37:22-139.178.89.65:47040.service: Deactivated successfully.
Oct 2 18:48:10.484261 systemd[1]: session-2.scope: Deactivated successfully.
Oct 2 18:48:10.485802 systemd-logind[1707]: Removed session 2.
Oct 2 18:48:10.505954 systemd[1]: Started sshd@2-172.31.19.37:22-139.178.89.65:47044.service.
Oct 2 18:48:10.686295 sshd[1992]: Accepted publickey for core from 139.178.89.65 port 47044 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8
Oct 2 18:48:10.689509 sshd[1992]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 18:48:10.698546 systemd[1]: Started session-3.scope.
Oct 2 18:48:10.699548 systemd-logind[1707]: New session 3 of user core.
Oct 2 18:48:10.829747 sshd[1992]: pam_unix(sshd:session): session closed for user core
Oct 2 18:48:10.835266 systemd[1]: sshd@2-172.31.19.37:22-139.178.89.65:47044.service: Deactivated successfully.
Oct 2 18:48:10.836481 systemd[1]: session-3.scope: Deactivated successfully.
Oct 2 18:48:10.837576 systemd-logind[1707]: Session 3 logged out. Waiting for processes to exit.
Oct 2 18:48:10.839180 systemd-logind[1707]: Removed session 3.
Oct 2 18:48:10.861300 systemd[1]: Started sshd@3-172.31.19.37:22-139.178.89.65:47050.service.
Oct 2 18:48:11.041720 sshd[1998]: Accepted publickey for core from 139.178.89.65 port 47050 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8
Oct 2 18:48:11.045532 sshd[1998]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 18:48:11.054471 systemd[1]: Started session-4.scope.
Oct 2 18:48:11.055225 systemd-logind[1707]: New session 4 of user core.
Oct 2 18:48:11.202790 sshd[1998]: pam_unix(sshd:session): session closed for user core
Oct 2 18:48:11.207677 systemd[1]: session-4.scope: Deactivated successfully.
Oct 2 18:48:11.209121 systemd[1]: sshd@3-172.31.19.37:22-139.178.89.65:47050.service: Deactivated successfully.
Oct 2 18:48:11.209364 systemd-logind[1707]: Session 4 logged out. Waiting for processes to exit.
Oct 2 18:48:11.211618 systemd-logind[1707]: Removed session 4.
Oct 2 18:48:11.230579 systemd[1]: Started sshd@4-172.31.19.37:22-139.178.89.65:47052.service.
Oct 2 18:48:11.408419 sshd[2004]: Accepted publickey for core from 139.178.89.65 port 47052 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8
Oct 2 18:48:11.412690 sshd[2004]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 18:48:11.420553 systemd-logind[1707]: New session 5 of user core.
Oct 2 18:48:11.421895 systemd[1]: Started session-5.scope.
Oct 2 18:48:11.580585 sudo[2007]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1
Oct 2 18:48:11.581601 sudo[2007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Oct 2 18:48:11.623722 dbus-daemon[1701]: avc: received setenforce notice (enforcing=1)
Oct 2 18:48:11.626401 sudo[2007]: pam_unix(sudo:session): session closed for user root
Oct 2 18:48:11.650898 sshd[2004]: pam_unix(sshd:session): session closed for user core
Oct 2 18:48:11.656777 systemd-logind[1707]: Session 5 logged out. Waiting for processes to exit.
Oct 2 18:48:11.657010 systemd[1]: session-5.scope: Deactivated successfully.
Oct 2 18:48:11.658338 systemd[1]: sshd@4-172.31.19.37:22-139.178.89.65:47052.service: Deactivated successfully.
Oct 2 18:48:11.660414 systemd-logind[1707]: Removed session 5.
Oct 2 18:48:11.681658 systemd[1]: Started sshd@5-172.31.19.37:22-139.178.89.65:47056.service.
Oct 2 18:48:11.866584 sshd[2011]: Accepted publickey for core from 139.178.89.65 port 47056 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8
Oct 2 18:48:11.868296 sshd[2011]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 18:48:11.877103 systemd[1]: Started session-6.scope.
Oct 2 18:48:11.877892 systemd-logind[1707]: New session 6 of user core.
Oct 2 18:48:11.997868 sudo[2015]: 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
Oct 2 18:48:11.998855 sudo[2015]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Oct 2 18:48:12.006241 sudo[2015]: pam_unix(sudo:session): session closed for user root
Oct 2 18:48:12.020011 sudo[2014]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules
Oct 2 18:48:12.021057 sudo[2014]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500)
Oct 2 18:48:12.045563 systemd[1]: Stopping audit-rules.service...
Oct 2 18:48:12.050000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1
Oct 2 18:48:12.052587 kernel: kauditd_printk_skb: 67 callbacks suppressed
Oct 2 18:48:12.052662 kernel: audit: type=1305 audit(1696272492.050:157): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1
Oct 2 18:48:12.050000 audit[2018]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffc7a4a6d0 a2=420 a3=0 items=0 ppid=1 pid=2018 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)
Oct 2 18:48:12.058798 auditctl[2018]: No rules
Oct 2 18:48:12.059836 systemd[1]: audit-rules.service: Deactivated successfully.
Oct 2 18:48:12.060165 systemd[1]: Stopped audit-rules.service.
Oct 2 18:48:12.071436 kernel: audit: type=1300 audit(1696272492.050:157): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffc7a4a6d0 a2=420 a3=0 items=0 ppid=1 pid=2018 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)
Oct 2 18:48:12.072697 systemd[1]: Starting audit-rules.service...
Oct 2 18:48:12.050000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44
Oct 2 18:48:12.078559 kernel: audit: type=1327 audit(1696272492.050:157): proctitle=2F7362696E2F617564697463746C002D44
Oct 2 18:48:12.057000 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'
Oct 2 18:48:12.089108 kernel: audit: type=1131 audit(1696272492.057:158): 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'
Oct 2 18:48:12.136496 augenrules[2035]: No rules
Oct 2 18:48:12.138239 systemd[1]: Finished audit-rules.service.
Oct 2 18:48:12.137000 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'
Oct 2 18:48:12.148712 sudo[2014]: pam_unix(sudo:session): session closed for user root
Oct 2 18:48:12.147000 audit[2014]: USER_END pid=2014 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.159551 kernel: audit: type=1130 audit(1696272492.137:159): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.159661 kernel: audit: type=1106 audit(1696272492.147:160): pid=2014 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.159705 kernel: audit: type=1104 audit(1696272492.147:161): pid=2014 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.147000 audit[2014]: CRED_DISP pid=2014 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.181605 sshd[2011]: pam_unix(sshd:session): session closed for user core
Oct 2 18:48:12.182000 audit[2011]: USER_END pid=2011 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.187899 systemd-logind[1707]: Session 6 logged out. Waiting for processes to exit.
Oct 2 18:48:12.188721 systemd[1]: session-6.scope: Deactivated successfully.
Oct 2 18:48:12.189841 systemd[1]: sshd@5-172.31.19.37:22-139.178.89.65:47056.service: Deactivated successfully.
Oct 2 18:48:12.193013 systemd-logind[1707]: Removed session 6.
Oct 2 18:48:12.182000 audit[2011]: CRED_DISP pid=2011 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.205504 kernel: audit: type=1106 audit(1696272492.182:162): pid=2011 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.205638 kernel: audit: type=1104 audit(1696272492.182:163): pid=2011 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.205683 kernel: audit: type=1131 audit(1696272492.189:164): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-172.31.19.37:22-139.178.89.65:47056 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.189000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-172.31.19.37:22-139.178.89.65:47056 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.214000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-172.31.19.37:22-139.178.89.65:47058 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.214732 systemd[1]: Started sshd@6-172.31.19.37:22-139.178.89.65:47058.service.
Oct 2 18:48:12.391000 audit[2041]: USER_ACCT pid=2041 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.392331 sshd[2041]: Accepted publickey for core from 139.178.89.65 port 47058 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8
Oct 2 18:48:12.394000 audit[2041]: CRED_ACQ pid=2041 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.394000 audit[2041]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffc4b80210 a2=3 a3=1 items=0 ppid=1 pid=2041 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=7 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null)
Oct 2 18:48:12.394000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D
Oct 2 18:48:12.396070 sshd[2041]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 18:48:12.405240 systemd[1]: Started session-7.scope.
Oct 2 18:48:12.406552 systemd-logind[1707]: New session 7 of user core.
Oct 2 18:48:12.414000 audit[2041]: USER_START pid=2041 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.420000 audit[2043]: CRED_ACQ pid=2043 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.536778 sshd[2041]: pam_unix(sshd:session): session closed for user core
Oct 2 18:48:12.538000 audit[2041]: USER_END pid=2041 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.539000 audit[2041]: CRED_DISP pid=2041 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.542797 systemd-logind[1707]: Session 7 logged out. Waiting for processes to exit.
Oct 2 18:48:12.543335 systemd[1]: sshd@6-172.31.19.37:22-139.178.89.65:47058.service: Deactivated successfully.
Oct 2 18:48:12.544532 systemd[1]: session-7.scope: Deactivated successfully.
Oct 2 18:48:12.543000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-172.31.19.37:22-139.178.89.65:47058 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.546105 systemd-logind[1707]: Removed session 7.
Oct 2 18:48:12.567691 systemd[1]: Started sshd@7-172.31.19.37:22-139.178.89.65:47066.service.
Oct 2 18:48:12.567000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-172.31.19.37:22-139.178.89.65:47066 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.744000 audit[2047]: USER_ACCT pid=2047 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.746411 sshd[2047]: Accepted publickey for core from 139.178.89.65 port 47066 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8
Oct 2 18:48:12.748000 audit[2047]: CRED_ACQ pid=2047 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.748000 audit[2047]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffd43d0ca0 a2=3 a3=1 items=0 ppid=1 pid=2047 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=8 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null)
Oct 2 18:48:12.748000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D
Oct 2 18:48:12.750938 sshd[2047]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0)
Oct 2 18:48:12.759703 systemd-logind[1707]: New session 8 of user core.
Oct 2 18:48:12.760177 systemd[1]: Started session-8.scope.
Oct 2 18:48:12.770000 audit[2047]: USER_START pid=2047 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=139.178.89.65 addr=139.178.89.65 terminal=ssh res=success'
Oct 2 18:48:12.776000 audit[2049]: CRED_ACQ pid=2049 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'
Oct 2 18:48:12.909558 sshd[2047]: pam_unix(sshd:session): session closed for user core
Oct 2 18:48:12.910000 audit[2047]: USER_END pid=2047 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'
Oct 2 18:48:12.911000 audit[2047]: CRED_DISP pid=2047 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'
Oct 2 18:48:12.914943 systemd-logind[1707]: Session 8 logged out. Waiting for processes to exit.
Oct 2 18:48:12.915539 systemd[1]: sshd@7-172.31.19.37:22-139.178.89.65:47066.service: Deactivated successfully.
Oct 2 18:48:12.914000 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.19.37:22-139.178.89.65:47066 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Oct 2 18:48:12.916757 systemd[1]: session-8.scope: Deactivated successfully.
Oct 2 18:48:12.918420 systemd-logind[1707]: Removed session 8.