Oct 2 18:47:52.163371 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Oct 2 18:47:52.163407 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:52.163429 kernel: efi: EFI v2.70 by EDK II Oct 2 18:47:52.163445 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7ac1aa98 MEMRESERVE=0x71accf98 Oct 2 18:47:52.163458 kernel: ACPI: Early table checksum verification disabled Oct 2 18:47:52.163472 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Oct 2 18:47:52.163488 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Oct 2 18:47:52.163502 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Oct 2 18:47:52.163516 kernel: ACPI: DSDT 0x0000000078640000 00154F (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Oct 2 18:47:52.163529 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Oct 2 18:47:52.163547 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Oct 2 18:47:52.163561 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Oct 2 18:47:52.163575 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Oct 2 18:47:52.163589 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Oct 2 18:47:52.163605 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Oct 2 18:47:52.163624 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Oct 2 18:47:52.163639 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Oct 2 18:47:52.163654 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Oct 2 18:47:52.163668 kernel: printk: bootconsole [uart0] enabled Oct 2 18:47:52.163682 kernel: NUMA: Failed to initialise from firmware Oct 2 18:47:52.163698 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Oct 2 18:47:52.163712 kernel: NUMA: NODE_DATA [mem 0x4b5841900-0x4b5846fff] Oct 2 18:47:52.163727 kernel: Zone ranges: Oct 2 18:47:52.163741 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Oct 2 18:47:52.163755 kernel: DMA32 empty Oct 2 18:47:52.163770 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Oct 2 18:47:52.163788 kernel: Movable zone start for each node Oct 2 18:47:52.163803 kernel: Early memory node ranges Oct 2 18:47:52.163817 kernel: node 0: [mem 0x0000000040000000-0x00000000786effff] Oct 2 18:47:52.163831 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Oct 2 18:47:52.163846 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Oct 2 18:47:52.163860 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Oct 2 18:47:52.163875 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Oct 2 18:47:52.163889 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Oct 2 18:47:52.163904 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Oct 2 18:47:52.163918 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Oct 2 18:47:52.163932 kernel: psci: probing for conduit method from ACPI. Oct 2 18:47:52.163946 kernel: psci: PSCIv1.0 detected in firmware. Oct 2 18:47:52.163965 kernel: psci: Using standard PSCI v0.2 function IDs Oct 2 18:47:52.163979 kernel: psci: Trusted OS migration not required Oct 2 18:47:52.164000 kernel: psci: SMC Calling Convention v1.1 Oct 2 18:47:52.164016 kernel: ACPI: SRAT not present Oct 2 18:47:52.164101 kernel: percpu: Embedded 29 pages/cpu s79960 r8192 d30632 u118784 Oct 2 18:47:52.164126 kernel: pcpu-alloc: s79960 r8192 d30632 u118784 alloc=29*4096 Oct 2 18:47:52.164142 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 2 18:47:52.164158 kernel: Detected PIPT I-cache on CPU0 Oct 2 18:47:52.164174 kernel: CPU features: detected: GIC system register CPU interface Oct 2 18:47:52.164189 kernel: CPU features: detected: Spectre-v2 Oct 2 18:47:52.164204 kernel: CPU features: detected: Spectre-v3a Oct 2 18:47:52.164219 kernel: CPU features: detected: Spectre-BHB Oct 2 18:47:52.164235 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 2 18:47:52.164250 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 2 18:47:52.164265 kernel: CPU features: detected: ARM erratum 1742098 Oct 2 18:47:52.164280 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Oct 2 18:47:52.164299 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Oct 2 18:47:52.164314 kernel: Policy zone: Normal Oct 2 18:47:52.164332 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:52.164349 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 2 18:47:52.164364 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 2 18:47:52.164380 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 2 18:47:52.164395 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 2 18:47:52.164411 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Oct 2 18:47:52.164427 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:52.164443 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 2 18:47:52.164461 kernel: trace event string verifier disabled Oct 2 18:47:52.164477 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 2 18:47:52.164493 kernel: rcu: RCU event tracing is enabled. Oct 2 18:47:52.164509 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 2 18:47:52.164524 kernel: Trampoline variant of Tasks RCU enabled. Oct 2 18:47:52.164539 kernel: Tracing variant of Tasks RCU enabled. Oct 2 18:47:52.164555 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 2 18:47:52.164570 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 2 18:47:52.164586 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 2 18:47:52.164601 kernel: GICv3: 96 SPIs implemented Oct 2 18:47:52.164615 kernel: GICv3: 0 Extended SPIs implemented Oct 2 18:47:52.164631 kernel: GICv3: Distributor has no Range Selector support Oct 2 18:47:52.164650 kernel: Root IRQ handler: gic_handle_irq Oct 2 18:47:52.164665 kernel: GICv3: 16 PPIs implemented Oct 2 18:47:52.164680 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Oct 2 18:47:52.164695 kernel: ACPI: SRAT not present Oct 2 18:47:52.164710 kernel: ITS [mem 0x10080000-0x1009ffff] Oct 2 18:47:52.164725 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000a0000 (indirect, esz 8, psz 64K, shr 1) Oct 2 18:47:52.164741 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000b0000 (flat, esz 8, psz 64K, shr 1) Oct 2 18:47:52.164756 kernel: GICv3: using LPI property table @0x00000004000c0000 Oct 2 18:47:52.164771 kernel: ITS: Using hypervisor restricted LPI range [128] Oct 2 18:47:52.164786 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000d0000 Oct 2 18:47:52.164802 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Oct 2 18:47:52.164821 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Oct 2 18:47:52.164837 kernel: sched_clock: 56 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Oct 2 18:47:52.164852 kernel: Console: colour dummy device 80x25 Oct 2 18:47:52.164868 kernel: printk: console [tty1] enabled Oct 2 18:47:52.164884 kernel: ACPI: Core revision 20210730 Oct 2 18:47:52.164899 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Oct 2 18:47:52.164916 kernel: pid_max: default: 32768 minimum: 301 Oct 2 18:47:52.164932 kernel: LSM: Security Framework initializing Oct 2 18:47:52.164947 kernel: SELinux: Initializing. Oct 2 18:47:52.164963 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 2 18:47:52.164983 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 2 18:47:52.164999 kernel: rcu: Hierarchical SRCU implementation. Oct 2 18:47:52.165014 kernel: Platform MSI: ITS@0x10080000 domain created Oct 2 18:47:52.165051 kernel: PCI/MSI: ITS@0x10080000 domain created Oct 2 18:47:52.165071 kernel: Remapping and enabling EFI services. Oct 2 18:47:52.165087 kernel: smp: Bringing up secondary CPUs ... Oct 2 18:47:52.165103 kernel: Detected PIPT I-cache on CPU1 Oct 2 18:47:52.165118 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Oct 2 18:47:52.165134 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000e0000 Oct 2 18:47:52.165155 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Oct 2 18:47:52.165170 kernel: smp: Brought up 1 node, 2 CPUs Oct 2 18:47:52.165186 kernel: SMP: Total of 2 processors activated. Oct 2 18:47:52.165201 kernel: CPU features: detected: 32-bit EL0 Support Oct 2 18:47:52.165216 kernel: CPU features: detected: 32-bit EL1 Support Oct 2 18:47:52.165232 kernel: CPU features: detected: CRC32 instructions Oct 2 18:47:52.165247 kernel: CPU: All CPU(s) started at EL1 Oct 2 18:47:52.165263 kernel: alternatives: patching kernel code Oct 2 18:47:52.165278 kernel: devtmpfs: initialized Oct 2 18:47:52.165297 kernel: KASLR disabled due to lack of seed Oct 2 18:47:52.165313 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 2 18:47:52.165329 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 2 18:47:52.165355 kernel: pinctrl core: initialized pinctrl subsystem Oct 2 18:47:52.165374 kernel: SMBIOS 3.0.0 present. Oct 2 18:47:52.165390 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Oct 2 18:47:52.165406 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 2 18:47:52.165422 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 2 18:47:52.165438 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 2 18:47:52.165455 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 2 18:47:52.165471 kernel: audit: initializing netlink subsys (disabled) Oct 2 18:47:52.165487 kernel: audit: type=2000 audit(0.247:1): state=initialized audit_enabled=0 res=1 Oct 2 18:47:52.165507 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 2 18:47:52.165523 kernel: cpuidle: using governor menu Oct 2 18:47:52.165539 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 2 18:47:52.165556 kernel: ASID allocator initialised with 32768 entries Oct 2 18:47:52.165571 kernel: ACPI: bus type PCI registered Oct 2 18:47:52.165591 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 2 18:47:52.165607 kernel: Serial: AMBA PL011 UART driver Oct 2 18:47:52.165624 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 2 18:47:52.165640 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Oct 2 18:47:52.165656 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 2 18:47:52.165672 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Oct 2 18:47:52.165688 kernel: cryptd: max_cpu_qlen set to 1000 Oct 2 18:47:52.165704 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 2 18:47:52.165720 kernel: ACPI: Added _OSI(Module Device) Oct 2 18:47:52.165740 kernel: ACPI: Added _OSI(Processor Device) Oct 2 18:47:52.165756 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 2 18:47:52.165772 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 2 18:47:52.165788 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 2 18:47:52.165804 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 2 18:47:52.165820 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 2 18:47:52.165836 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 2 18:47:52.165852 kernel: ACPI: Interpreter enabled Oct 2 18:47:52.165868 kernel: ACPI: Using GIC for interrupt routing Oct 2 18:47:52.165888 kernel: ACPI: MCFG table detected, 1 entries Oct 2 18:47:52.165904 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Oct 2 18:47:52.166316 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 2 18:47:52.166514 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 2 18:47:52.166725 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 2 18:47:52.166917 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Oct 2 18:47:52.167147 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Oct 2 18:47:52.167178 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Oct 2 18:47:52.167196 kernel: acpiphp: Slot [1] registered Oct 2 18:47:52.167213 kernel: acpiphp: Slot [2] registered Oct 2 18:47:52.167230 kernel: acpiphp: Slot [3] registered Oct 2 18:47:52.167246 kernel: acpiphp: Slot [4] registered Oct 2 18:47:52.167262 kernel: acpiphp: Slot [5] registered Oct 2 18:47:52.167278 kernel: acpiphp: Slot [6] registered Oct 2 18:47:52.167294 kernel: acpiphp: Slot [7] registered Oct 2 18:47:52.167311 kernel: acpiphp: Slot [8] registered Oct 2 18:47:52.167332 kernel: acpiphp: Slot [9] registered Oct 2 18:47:52.167348 kernel: acpiphp: Slot [10] registered Oct 2 18:47:52.167365 kernel: acpiphp: Slot [11] registered Oct 2 18:47:52.167381 kernel: acpiphp: Slot [12] registered Oct 2 18:47:52.167397 kernel: acpiphp: Slot [13] registered Oct 2 18:47:52.167413 kernel: acpiphp: Slot [14] registered Oct 2 18:47:52.167429 kernel: acpiphp: Slot [15] registered Oct 2 18:47:52.167445 kernel: acpiphp: Slot [16] registered Oct 2 18:47:52.167462 kernel: acpiphp: Slot [17] registered Oct 2 18:47:52.167478 kernel: acpiphp: Slot [18] registered Oct 2 18:47:52.167499 kernel: acpiphp: Slot [19] registered Oct 2 18:47:52.167516 kernel: acpiphp: Slot [20] registered Oct 2 18:47:52.167532 kernel: acpiphp: Slot [21] registered Oct 2 18:47:52.167548 kernel: acpiphp: Slot [22] registered Oct 2 18:47:52.167564 kernel: acpiphp: Slot [23] registered Oct 2 18:47:52.167580 kernel: acpiphp: Slot [24] registered Oct 2 18:47:52.167597 kernel: acpiphp: Slot [25] registered Oct 2 18:47:52.167613 kernel: acpiphp: Slot [26] registered Oct 2 18:47:52.167630 kernel: acpiphp: Slot [27] registered Oct 2 18:47:52.167649 kernel: acpiphp: Slot [28] registered Oct 2 18:47:52.167665 kernel: acpiphp: Slot [29] registered Oct 2 18:47:52.167681 kernel: acpiphp: Slot [30] registered Oct 2 18:47:52.167698 kernel: acpiphp: Slot [31] registered Oct 2 18:47:52.167714 kernel: PCI host bridge to bus 0000:00 Oct 2 18:47:52.167929 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Oct 2 18:47:52.168154 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 2 18:47:52.168345 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Oct 2 18:47:52.168530 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Oct 2 18:47:52.168757 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Oct 2 18:47:52.168976 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Oct 2 18:47:52.169375 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Oct 2 18:47:52.171199 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Oct 2 18:47:52.171396 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Oct 2 18:47:52.171597 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 2 18:47:52.171815 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Oct 2 18:47:52.172010 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Oct 2 18:47:52.179694 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Oct 2 18:47:52.179947 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Oct 2 18:47:52.180194 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Oct 2 18:47:52.180417 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Oct 2 18:47:52.180644 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Oct 2 18:47:52.180869 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Oct 2 18:47:52.181109 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Oct 2 18:47:52.181335 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Oct 2 18:47:52.181551 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Oct 2 18:47:52.181760 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 2 18:47:52.181968 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Oct 2 18:47:52.181996 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 2 18:47:52.182014 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 2 18:47:52.182048 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 2 18:47:52.182067 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 2 18:47:52.182084 kernel: iommu: Default domain type: Translated Oct 2 18:47:52.182100 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 2 18:47:52.182117 kernel: vgaarb: loaded Oct 2 18:47:52.182133 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 2 18:47:52.182150 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 2 18:47:52.182171 kernel: PTP clock support registered Oct 2 18:47:52.182188 kernel: Registered efivars operations Oct 2 18:47:52.182204 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 2 18:47:52.182220 kernel: VFS: Disk quotas dquot_6.6.0 Oct 2 18:47:52.182237 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 2 18:47:52.182253 kernel: pnp: PnP ACPI init Oct 2 18:47:52.182493 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Oct 2 18:47:52.182518 kernel: pnp: PnP ACPI: found 1 devices Oct 2 18:47:52.182535 kernel: NET: Registered PF_INET protocol family Oct 2 18:47:52.182569 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 2 18:47:52.182591 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 2 18:47:52.182607 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 2 18:47:52.182624 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 2 18:47:52.182641 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Oct 2 18:47:52.182657 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 2 18:47:52.182673 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 2 18:47:52.182690 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 2 18:47:52.182706 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 2 18:47:52.182727 kernel: PCI: CLS 0 bytes, default 64 Oct 2 18:47:52.182743 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Oct 2 18:47:52.182759 kernel: kvm [1]: HYP mode not available Oct 2 18:47:52.182775 kernel: Initialise system trusted keyrings Oct 2 18:47:52.182792 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 2 18:47:52.182808 kernel: Key type asymmetric registered Oct 2 18:47:52.182824 kernel: Asymmetric key parser 'x509' registered Oct 2 18:47:52.182840 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 2 18:47:52.182856 kernel: io scheduler mq-deadline registered Oct 2 18:47:52.182876 kernel: io scheduler kyber registered Oct 2 18:47:52.182892 kernel: io scheduler bfq registered Oct 2 18:47:52.192815 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Oct 2 18:47:52.192860 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 2 18:47:52.192878 kernel: ACPI: button: Power Button [PWRB] Oct 2 18:47:52.192895 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 2 18:47:52.192913 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Oct 2 18:47:52.193150 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Oct 2 18:47:52.193183 kernel: printk: console [ttyS0] disabled Oct 2 18:47:52.193201 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Oct 2 18:47:52.193218 kernel: printk: console [ttyS0] enabled Oct 2 18:47:52.193234 kernel: printk: bootconsole [uart0] disabled Oct 2 18:47:52.193250 kernel: thunder_xcv, ver 1.0 Oct 2 18:47:52.193266 kernel: thunder_bgx, ver 1.0 Oct 2 18:47:52.193282 kernel: nicpf, ver 1.0 Oct 2 18:47:52.193298 kernel: nicvf, ver 1.0 Oct 2 18:47:52.193500 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 2 18:47:52.193689 kernel: rtc-efi rtc-efi.0: setting system clock to 2023-10-02T18:47:51 UTC (1696272471) Oct 2 18:47:52.193712 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 2 18:47:52.193729 kernel: NET: Registered PF_INET6 protocol family Oct 2 18:47:52.193745 kernel: Segment Routing with IPv6 Oct 2 18:47:52.193761 kernel: In-situ OAM (IOAM) with IPv6 Oct 2 18:47:52.193777 kernel: NET: Registered PF_PACKET protocol family Oct 2 18:47:52.193794 kernel: Key type dns_resolver registered Oct 2 18:47:52.193810 kernel: registered taskstats version 1 Oct 2 18:47:52.193830 kernel: Loading compiled-in X.509 certificates Oct 2 18:47:52.193847 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.132-flatcar: 3a2a38edc68cb70dc60ec0223a6460557b3bb28d' Oct 2 18:47:52.193863 kernel: Key type .fscrypt registered Oct 2 18:47:52.193879 kernel: Key type fscrypt-provisioning registered Oct 2 18:47:52.193895 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 2 18:47:52.193911 kernel: ima: Allocated hash algorithm: sha1 Oct 2 18:47:52.193927 kernel: ima: No architecture policies found Oct 2 18:47:52.193944 kernel: Freeing unused kernel memory: 34560K Oct 2 18:47:52.193960 kernel: Run /init as init process Oct 2 18:47:52.193980 kernel: with arguments: Oct 2 18:47:52.193996 kernel: /init Oct 2 18:47:52.194012 kernel: with environment: Oct 2 18:47:52.194129 kernel: HOME=/ Oct 2 18:47:52.194152 kernel: TERM=linux Oct 2 18:47:52.194168 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 2 18:47:52.194190 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:52.194262 systemd[1]: Detected virtualization amazon. Oct 2 18:47:52.194358 systemd[1]: Detected architecture arm64. Oct 2 18:47:52.194380 systemd[1]: Running in initrd. Oct 2 18:47:52.194398 systemd[1]: No hostname configured, using default hostname. Oct 2 18:47:52.194416 systemd[1]: Hostname set to . Oct 2 18:47:52.194434 systemd[1]: Initializing machine ID from VM UUID. Oct 2 18:47:52.194451 systemd[1]: Queued start job for default target initrd.target. Oct 2 18:47:52.194469 systemd[1]: Started systemd-ask-password-console.path. Oct 2 18:47:52.194486 systemd[1]: Reached target cryptsetup.target. Oct 2 18:47:52.194508 systemd[1]: Reached target paths.target. Oct 2 18:47:52.194526 systemd[1]: Reached target slices.target. Oct 2 18:47:52.194543 systemd[1]: Reached target swap.target. Oct 2 18:47:52.194700 systemd[1]: Reached target timers.target. Oct 2 18:47:52.195129 systemd[1]: Listening on iscsid.socket. Oct 2 18:47:52.195270 systemd[1]: Listening on iscsiuio.socket. Oct 2 18:47:52.195566 systemd[1]: Listening on systemd-journald-audit.socket. Oct 2 18:47:52.195909 systemd[1]: Listening on systemd-journald-dev-log.socket. Oct 2 18:47:52.195936 systemd[1]: Listening on systemd-journald.socket. Oct 2 18:47:52.195954 systemd[1]: Listening on systemd-networkd.socket. Oct 2 18:47:52.195972 systemd[1]: Listening on systemd-udevd-control.socket. Oct 2 18:47:52.195990 systemd[1]: Listening on systemd-udevd-kernel.socket. Oct 2 18:47:52.196008 systemd[1]: Reached target sockets.target. Oct 2 18:47:52.196050 systemd[1]: Starting kmod-static-nodes.service... Oct 2 18:47:52.196074 systemd[1]: Finished network-cleanup.service. Oct 2 18:47:52.196092 systemd[1]: Starting systemd-fsck-usr.service... Oct 2 18:47:52.196110 systemd[1]: Starting systemd-journald.service... Oct 2 18:47:52.196134 systemd[1]: Starting systemd-modules-load.service... Oct 2 18:47:52.196152 systemd[1]: Starting systemd-resolved.service... Oct 2 18:47:52.196169 systemd[1]: Starting systemd-vconsole-setup.service... Oct 2 18:47:52.196188 systemd[1]: Finished kmod-static-nodes.service. Oct 2 18:47:52.196205 systemd[1]: Finished systemd-fsck-usr.service. Oct 2 18:47:52.196223 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Oct 2 18:47:52.196241 systemd[1]: Finished systemd-vconsole-setup.service. Oct 2 18:47:52.196259 kernel: audit: type=1130 audit(1696272472.171:2): 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:52.196281 systemd[1]: Starting dracut-cmdline-ask.service... Oct 2 18:47:52.196303 systemd-journald[309]: Journal started Oct 2 18:47:52.196390 systemd-journald[309]: Runtime Journal (/run/log/journal/ec2d62918ff14c77d2d504ffd4bf58b7) is 8.0M, max 75.4M, 67.4M free. Oct 2 18:47:52.171000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:47:52.132708 systemd-modules-load[310]: Inserted module 'overlay' Oct 2 18:47:52.222066 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Oct 2 18:47:52.222143 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:52.222172 kernel: audit: type=1130 audit(1696272472.209:3): 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:52.222197 systemd[1]: Started systemd-journald.service. Oct 2 18:47:52.209000 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:52.227000 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:52.243093 kernel: audit: type=1130 audit(1696272472.227:4): 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:52.243159 kernel: Bridge firewalling registered Oct 2 18:47:52.240272 systemd-modules-load[310]: Inserted module 'br_netfilter' Oct 2 18:47:52.264069 kernel: SCSI subsystem initialized Oct 2 18:47:52.272446 systemd-resolved[311]: Positive Trust Anchors: Oct 2 18:47:52.274645 systemd-resolved[311]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 2 18:47:52.292123 systemd-resolved[311]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 2 18:47:52.317421 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:52.317459 kernel: device-mapper: uevent: version 1.0.3 Oct 2 18:47:52.317482 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Oct 2 18:47:52.317505 kernel: audit: type=1130 audit(1696272472.314: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:52.314000 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:52.312865 systemd-modules-load[310]: Inserted module 'dm_multipath' Oct 2 18:47:52.315132 systemd[1]: Finished systemd-modules-load.service. Oct 2 18:47:52.330116 systemd[1]: Starting systemd-sysctl.service... Oct 2 18:47:52.332433 systemd[1]: Finished dracut-cmdline-ask.service. Oct 2 18:47:52.338000 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:52.358294 systemd[1]: Starting dracut-cmdline.service... Oct 2 18:47:52.362420 kernel: audit: type=1130 audit(1696272472.338:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:47:52.379988 systemd[1]: Finished systemd-sysctl.service. Oct 2 18:47:52.390751 kernel: audit: type=1130 audit(1696272472.379:7): 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:52.379000 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:52.408566 dracut-cmdline[331]: dracut-dracut-053 Oct 2 18:47:52.418265 dracut-cmdline[331]: 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:52.636071 kernel: Loading iSCSI transport class v2.0-870. Oct 2 18:47:52.650090 kernel: iscsi: registered transport (tcp) Oct 2 18:47:52.676309 kernel: iscsi: registered transport (qla4xxx) Oct 2 18:47:52.676385 kernel: QLogic iSCSI HBA Driver Oct 2 18:47:52.828081 kernel: random: crng init done Oct 2 18:47:52.828017 systemd-resolved[311]: Defaulting to hostname 'linux'. Oct 2 18:47:52.833964 systemd[1]: Started systemd-resolved.service. Oct 2 18:47:52.840000 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:52.841378 systemd[1]: Reached target nss-lookup.target. Oct 2 18:47:52.856276 kernel: audit: type=1130 audit(1696272472.840:8): 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:52.891484 systemd[1]: Finished dracut-cmdline.service. Oct 2 18:47:52.896000 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:52.898598 systemd[1]: Starting dracut-pre-udev.service... Oct 2 18:47:52.908342 kernel: audit: type=1130 audit(1696272472.896:9): 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:52.992066 kernel: raid6: neonx8 gen() 6421 MB/s Oct 2 18:47:53.010060 kernel: raid6: neonx8 xor() 4740 MB/s Oct 2 18:47:53.028059 kernel: raid6: neonx4 gen() 6616 MB/s Oct 2 18:47:53.046060 kernel: raid6: neonx4 xor() 4946 MB/s Oct 2 18:47:53.064059 kernel: raid6: neonx2 gen() 5824 MB/s Oct 2 18:47:53.082060 kernel: raid6: neonx2 xor() 4538 MB/s Oct 2 18:47:53.100059 kernel: raid6: neonx1 gen() 4519 MB/s Oct 2 18:47:53.118060 kernel: raid6: neonx1 xor() 3689 MB/s Oct 2 18:47:53.136059 kernel: raid6: int64x8 gen() 3446 MB/s Oct 2 18:47:53.154059 kernel: raid6: int64x8 xor() 2087 MB/s Oct 2 18:47:53.172059 kernel: raid6: int64x4 gen() 3868 MB/s Oct 2 18:47:53.190059 kernel: raid6: int64x4 xor() 2201 MB/s Oct 2 18:47:53.208059 kernel: raid6: int64x2 gen() 3628 MB/s Oct 2 18:47:53.226059 kernel: raid6: int64x2 xor() 1954 MB/s Oct 2 18:47:53.244059 kernel: raid6: int64x1 gen() 2780 MB/s Oct 2 18:47:53.263577 kernel: raid6: int64x1 xor() 1454 MB/s Oct 2 18:47:53.263606 kernel: raid6: using algorithm neonx4 gen() 6616 MB/s Oct 2 18:47:53.263629 kernel: raid6: .... xor() 4946 MB/s, rmw enabled Oct 2 18:47:53.265399 kernel: raid6: using neon recovery algorithm Oct 2 18:47:53.284066 kernel: xor: measuring software checksum speed Oct 2 18:47:53.286057 kernel: 8regs : 9332 MB/sec Oct 2 18:47:53.289060 kernel: 32regs : 11107 MB/sec Oct 2 18:47:53.293041 kernel: arm64_neon : 9626 MB/sec Oct 2 18:47:53.293073 kernel: xor: using function: 32regs (11107 MB/sec) Oct 2 18:47:53.382074 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Oct 2 18:47:53.420565 systemd[1]: Finished dracut-pre-udev.service. Oct 2 18:47:53.421000 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:53.430000 audit: BPF prog-id=7 op=LOAD Oct 2 18:47:53.430000 audit: BPF prog-id=8 op=LOAD Oct 2 18:47:53.432061 kernel: audit: type=1130 audit(1696272473.421:10): 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:53.432615 systemd[1]: Starting systemd-udevd.service... Oct 2 18:47:53.468813 systemd-udevd[508]: Using default interface naming scheme 'v252'. Oct 2 18:47:53.480158 systemd[1]: Started systemd-udevd.service. Oct 2 18:47:53.481000 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:53.491273 systemd[1]: Starting dracut-pre-trigger.service... Oct 2 18:47:53.547962 dracut-pre-trigger[522]: rd.md=0: removing MD RAID activation Oct 2 18:47:53.653666 systemd[1]: Finished dracut-pre-trigger.service. Oct 2 18:47:53.654000 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:53.657333 systemd[1]: Starting systemd-udev-trigger.service... Oct 2 18:47:53.769600 systemd[1]: Finished systemd-udev-trigger.service. Oct 2 18:47:53.770000 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:53.905209 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 2 18:47:53.905280 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Oct 2 18:47:53.920961 kernel: ena 0000:00:05.0: ENA device version: 0.10 Oct 2 18:47:53.921301 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Oct 2 18:47:53.925395 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Oct 2 18:47:53.925454 kernel: nvme nvme0: pci function 0000:00:04.0 Oct 2 18:47:53.937069 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:7b:74:c5:59:0d Oct 2 18:47:53.937352 kernel: nvme nvme0: 2/0/0 default/read/poll queues Oct 2 18:47:53.945121 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 2 18:47:53.945173 kernel: GPT:9289727 != 16777215 Oct 2 18:47:53.945207 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 2 18:47:53.947319 kernel: GPT:9289727 != 16777215 Oct 2 18:47:53.948629 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 2 18:47:53.952051 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 2 18:47:53.958342 (udev-worker)[557]: Network interface NamePolicy= disabled on kernel command line. Oct 2 18:47:54.031085 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by (udev-worker) (558) Oct 2 18:47:54.101658 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Oct 2 18:47:54.220391 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Oct 2 18:47:54.251114 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Oct 2 18:47:54.258536 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Oct 2 18:47:54.276697 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Oct 2 18:47:54.294104 systemd[1]: Starting disk-uuid.service... Oct 2 18:47:54.321064 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 2 18:47:54.322193 disk-uuid[667]: Primary Header is updated. Oct 2 18:47:54.322193 disk-uuid[667]: Secondary Entries is updated. Oct 2 18:47:54.322193 disk-uuid[667]: Secondary Header is updated. Oct 2 18:47:54.340060 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 2 18:47:55.346069 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 2 18:47:55.346247 disk-uuid[668]: The operation has completed successfully. Oct 2 18:47:55.638170 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 2 18:47:55.638366 systemd[1]: Finished disk-uuid.service. Oct 2 18:47:55.640000 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:55.640000 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:55.645574 systemd[1]: Starting verity-setup.service... Oct 2 18:47:55.701196 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 2 18:47:55.792205 systemd[1]: Found device dev-mapper-usr.device. Oct 2 18:47:55.800689 systemd[1]: Mounting sysusr-usr.mount... Oct 2 18:47:55.812963 systemd[1]: Finished verity-setup.service. Oct 2 18:47:55.815000 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:55.818339 kernel: kauditd_printk_skb: 7 callbacks suppressed Oct 2 18:47:55.818389 kernel: audit: type=1130 audit(1696272475.815:18): 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:55.901065 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Oct 2 18:47:55.902287 systemd[1]: Mounted sysusr-usr.mount. Oct 2 18:47:55.906359 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Oct 2 18:47:55.912861 systemd[1]: Starting ignition-setup.service... Oct 2 18:47:55.918081 systemd[1]: Starting parse-ip-for-networkd.service... Oct 2 18:47:55.957257 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Oct 2 18:47:55.957323 kernel: BTRFS info (device nvme0n1p6): using free space tree Oct 2 18:47:55.957348 kernel: BTRFS info (device nvme0n1p6): has skinny extents Oct 2 18:47:55.978069 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 2 18:47:56.011090 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 2 18:47:56.044698 systemd[1]: Finished ignition-setup.service. Oct 2 18:47:56.045000 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:56.048253 systemd[1]: Starting ignition-fetch-offline.service... Oct 2 18:47:56.063080 kernel: audit: type=1130 audit(1696272476.045:19): 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:56.286720 systemd[1]: Finished parse-ip-for-networkd.service. Oct 2 18:47:56.287000 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:56.298000 audit: BPF prog-id=9 op=LOAD Oct 2 18:47:56.302191 kernel: audit: type=1130 audit(1696272476.287:20): 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:56.302243 kernel: audit: type=1334 audit(1696272476.298:21): prog-id=9 op=LOAD Oct 2 18:47:56.300467 systemd[1]: Starting systemd-networkd.service... Oct 2 18:47:56.359082 systemd-networkd[1180]: lo: Link UP Oct 2 18:47:56.359103 systemd-networkd[1180]: lo: Gained carrier Oct 2 18:47:56.363403 systemd-networkd[1180]: Enumeration completed Oct 2 18:47:56.378517 kernel: audit: type=1130 audit(1696272476.365:22): 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:56.365000 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:56.363914 systemd-networkd[1180]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 2 18:47:56.364070 systemd[1]: Started systemd-networkd.service. Oct 2 18:47:56.366314 systemd[1]: Reached target network.target. Oct 2 18:47:56.369905 systemd[1]: Starting iscsiuio.service... Oct 2 18:47:56.393467 systemd-networkd[1180]: eth0: Link UP Oct 2 18:47:56.393487 systemd-networkd[1180]: eth0: Gained carrier Oct 2 18:47:56.402416 systemd[1]: Started iscsiuio.service. Oct 2 18:47:56.403000 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:56.407561 systemd[1]: Starting iscsid.service... Oct 2 18:47:56.419791 kernel: audit: type=1130 audit(1696272476.403:23): 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:56.421288 systemd-networkd[1180]: eth0: DHCPv4 address 172.31.22.29/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 2 18:47:56.430409 iscsid[1190]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 2 18:47:56.434192 iscsid[1190]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Oct 2 18:47:56.434192 iscsid[1190]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 2 18:47:56.449687 iscsid[1190]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 2 18:47:56.449687 iscsid[1190]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 2 18:47:56.456024 iscsid[1190]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 2 18:47:56.469315 systemd[1]: Started iscsid.service. Oct 2 18:47:56.471000 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:56.479506 systemd[1]: Starting dracut-initqueue.service... Oct 2 18:47:56.483659 kernel: audit: type=1130 audit(1696272476.471:24): 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:56.522342 systemd[1]: Finished dracut-initqueue.service. Oct 2 18:47:56.536743 kernel: audit: type=1130 audit(1696272476.523:25): 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:56.523000 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:56.526328 systemd[1]: Reached target remote-fs-pre.target. Oct 2 18:47:56.537587 systemd[1]: Reached target remote-cryptsetup.target. Oct 2 18:47:56.543247 systemd[1]: Reached target remote-fs.target. Oct 2 18:47:56.546836 systemd[1]: Starting dracut-pre-mount.service... Oct 2 18:47:56.582916 systemd[1]: Finished dracut-pre-mount.service. Oct 2 18:47:56.582000 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:56.595075 kernel: audit: type=1130 audit(1696272476.582:26): 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:56.642451 ignition[1098]: Ignition 2.14.0 Oct 2 18:47:56.642481 ignition[1098]: Stage: fetch-offline Oct 2 18:47:56.642881 ignition[1098]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 18:47:56.642991 ignition[1098]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 18:47:56.666713 ignition[1098]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 18:47:56.669922 ignition[1098]: Ignition finished successfully Oct 2 18:47:56.673362 systemd[1]: Finished ignition-fetch-offline.service. Oct 2 18:47:56.674000 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:56.677997 systemd[1]: Starting ignition-fetch.service... Oct 2 18:47:56.702191 kernel: audit: type=1130 audit(1696272476.674:27): 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:56.709879 ignition[1204]: Ignition 2.14.0 Oct 2 18:47:56.709907 ignition[1204]: Stage: fetch Oct 2 18:47:56.710286 ignition[1204]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 18:47:56.710344 ignition[1204]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 18:47:56.727312 ignition[1204]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 18:47:56.730355 ignition[1204]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 18:47:56.739340 ignition[1204]: INFO : PUT result: OK Oct 2 18:47:56.742968 ignition[1204]: DEBUG : parsed url from cmdline: "" Oct 2 18:47:56.742968 ignition[1204]: INFO : no config URL provided Oct 2 18:47:56.742968 ignition[1204]: INFO : reading system config file "/usr/lib/ignition/user.ign" Oct 2 18:47:56.750180 ignition[1204]: INFO : no config at "/usr/lib/ignition/user.ign" Oct 2 18:47:56.750180 ignition[1204]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 18:47:56.755909 ignition[1204]: INFO : PUT result: OK Oct 2 18:47:56.757704 ignition[1204]: INFO : GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Oct 2 18:47:56.761178 ignition[1204]: INFO : GET result: OK Oct 2 18:47:56.762969 ignition[1204]: DEBUG : parsing config with SHA512: 9b8f381734e56d5dbb59b68ee76b1949fb5bb4336cb8f7b5b0f21c195c6e27f918511ab8bbd282b9f0079f4ccdde8243d21277f88c22e75439f162554bcd8341 Oct 2 18:47:56.772390 unknown[1204]: fetched base config from "system" Oct 2 18:47:56.772419 unknown[1204]: fetched base config from "system" Oct 2 18:47:56.772434 unknown[1204]: fetched user config from "aws" Oct 2 18:47:56.778856 ignition[1204]: fetch: fetch complete Oct 2 18:47:56.778881 ignition[1204]: fetch: fetch passed Oct 2 18:47:56.778982 ignition[1204]: Ignition finished successfully Oct 2 18:47:56.786589 systemd[1]: Finished ignition-fetch.service. Oct 2 18:47:56.789000 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:56.791880 systemd[1]: Starting ignition-kargs.service... Oct 2 18:47:56.826819 ignition[1210]: Ignition 2.14.0 Oct 2 18:47:56.826849 ignition[1210]: Stage: kargs Oct 2 18:47:56.827245 ignition[1210]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 18:47:56.827305 ignition[1210]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 18:47:56.841785 ignition[1210]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 18:47:56.844907 ignition[1210]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 18:47:56.849062 ignition[1210]: INFO : PUT result: OK Oct 2 18:47:56.853413 ignition[1210]: kargs: kargs passed Oct 2 18:47:56.855326 ignition[1210]: Ignition finished successfully Oct 2 18:47:56.859012 systemd[1]: Finished ignition-kargs.service. Oct 2 18:47:56.861000 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:56.864334 systemd[1]: Starting ignition-disks.service... Oct 2 18:47:56.892346 ignition[1216]: Ignition 2.14.0 Oct 2 18:47:56.892377 ignition[1216]: Stage: disks Oct 2 18:47:56.892798 ignition[1216]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 18:47:56.892884 ignition[1216]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 18:47:56.908971 ignition[1216]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 18:47:56.914287 ignition[1216]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 18:47:56.917598 ignition[1216]: INFO : PUT result: OK Oct 2 18:47:56.921987 ignition[1216]: disks: disks passed Oct 2 18:47:56.922269 ignition[1216]: Ignition finished successfully Oct 2 18:47:56.927327 systemd[1]: Finished ignition-disks.service. Oct 2 18:47:56.930000 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:56.931336 systemd[1]: Reached target initrd-root-device.target. Oct 2 18:47:56.935620 systemd[1]: Reached target local-fs-pre.target. Oct 2 18:47:56.939629 systemd[1]: Reached target local-fs.target. Oct 2 18:47:56.943379 systemd[1]: Reached target sysinit.target. Oct 2 18:47:56.947149 systemd[1]: Reached target basic.target. Oct 2 18:47:56.952246 systemd[1]: Starting systemd-fsck-root.service... Oct 2 18:47:57.002986 systemd-fsck[1224]: ROOT: clean, 603/553520 files, 56011/553472 blocks Oct 2 18:47:57.013350 systemd[1]: Finished systemd-fsck-root.service. Oct 2 18:47:57.014000 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:57.018776 systemd[1]: Mounting sysroot.mount... Oct 2 18:47:57.048055 kernel: EXT4-fs (nvme0n1p9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Oct 2 18:47:57.050778 systemd[1]: Mounted sysroot.mount. Oct 2 18:47:57.055624 systemd[1]: Reached target initrd-root-fs.target. Oct 2 18:47:57.083612 systemd[1]: Mounting sysroot-usr.mount... Oct 2 18:47:57.087960 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Oct 2 18:47:57.099094 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 2 18:47:57.103431 systemd[1]: Reached target ignition-diskful.target. Oct 2 18:47:57.109493 systemd[1]: Mounted sysroot-usr.mount. Oct 2 18:47:57.128244 systemd[1]: Mounting sysroot-usr-share-oem.mount... Oct 2 18:47:57.141178 systemd[1]: Starting initrd-setup-root.service... Oct 2 18:47:57.158534 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by mount (1241) Oct 2 18:47:57.164131 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Oct 2 18:47:57.164198 kernel: BTRFS info (device nvme0n1p6): using free space tree Oct 2 18:47:57.164223 kernel: BTRFS info (device nvme0n1p6): has skinny extents Oct 2 18:47:57.177068 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 2 18:47:57.179346 initrd-setup-root[1246]: cut: /sysroot/etc/passwd: No such file or directory Oct 2 18:47:57.184111 systemd[1]: Mounted sysroot-usr-share-oem.mount. Oct 2 18:47:57.217450 initrd-setup-root[1272]: cut: /sysroot/etc/group: No such file or directory Oct 2 18:47:57.235732 initrd-setup-root[1280]: cut: /sysroot/etc/shadow: No such file or directory Oct 2 18:47:57.254909 initrd-setup-root[1288]: cut: /sysroot/etc/gshadow: No such file or directory Oct 2 18:47:57.455401 systemd[1]: Finished initrd-setup-root.service. Oct 2 18:47:57.458000 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:57.460924 systemd[1]: Starting ignition-mount.service... Oct 2 18:47:57.465917 systemd[1]: Starting sysroot-boot.service... Oct 2 18:47:57.497871 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. Oct 2 18:47:57.498079 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. Oct 2 18:47:57.538989 systemd[1]: Finished sysroot-boot.service. Oct 2 18:47:57.541000 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:57.559228 systemd-networkd[1180]: eth0: Gained IPv6LL Oct 2 18:47:57.562632 ignition[1309]: INFO : Ignition 2.14.0 Oct 2 18:47:57.562632 ignition[1309]: INFO : Stage: mount Oct 2 18:47:57.566484 ignition[1309]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 18:47:57.566484 ignition[1309]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 18:47:57.587103 ignition[1309]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 18:47:57.590638 ignition[1309]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 18:47:57.594204 ignition[1309]: INFO : PUT result: OK Oct 2 18:47:57.598994 ignition[1309]: INFO : mount: mount passed Oct 2 18:47:57.601148 ignition[1309]: INFO : Ignition finished successfully Oct 2 18:47:57.604617 systemd[1]: Finished ignition-mount.service. Oct 2 18:47:57.607000 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:57.609577 systemd[1]: Starting ignition-files.service... Oct 2 18:47:57.632676 systemd[1]: Mounting sysroot-usr-share-oem.mount... Oct 2 18:47:57.656075 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by mount (1316) Oct 2 18:47:57.662299 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Oct 2 18:47:57.662344 kernel: BTRFS info (device nvme0n1p6): using free space tree Oct 2 18:47:57.662370 kernel: BTRFS info (device nvme0n1p6): has skinny extents Oct 2 18:47:57.671065 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 2 18:47:57.676343 systemd[1]: Mounted sysroot-usr-share-oem.mount. Oct 2 18:47:57.711176 ignition[1335]: INFO : Ignition 2.14.0 Oct 2 18:47:57.714844 ignition[1335]: INFO : Stage: files Oct 2 18:47:57.714844 ignition[1335]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 18:47:57.714844 ignition[1335]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 18:47:57.731891 ignition[1335]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 18:47:57.731891 ignition[1335]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 18:47:57.738877 ignition[1335]: INFO : PUT result: OK Oct 2 18:47:57.743274 ignition[1335]: DEBUG : files: compiled without relabeling support, skipping Oct 2 18:47:57.748209 ignition[1335]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 2 18:47:57.748209 ignition[1335]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 2 18:47:57.775909 ignition[1335]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 2 18:47:57.779457 ignition[1335]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 2 18:47:57.783906 unknown[1335]: wrote ssh authorized keys file for user: core Oct 2 18:47:57.786478 ignition[1335]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 2 18:47:57.790747 ignition[1335]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/eks/bootstrap.sh" Oct 2 18:47:57.795195 ignition[1335]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Oct 2 18:47:57.806386 ignition[1335]: INFO : op(1): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem914007921" Oct 2 18:47:57.809906 ignition[1335]: CRITICAL : op(1): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem914007921": device or resource busy Oct 2 18:47:57.817759 kernel: BTRFS info: devid 1 device path /dev/nvme0n1p6 changed to /dev/disk/by-label/OEM scanned by ignition (1337) Oct 2 18:47:57.817795 ignition[1335]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem914007921", trying btrfs: device or resource busy Oct 2 18:47:57.817795 ignition[1335]: INFO : op(2): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem914007921" Oct 2 18:47:57.825654 ignition[1335]: INFO : op(2): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem914007921" Oct 2 18:47:57.838911 ignition[1335]: INFO : op(3): [started] unmounting "/mnt/oem914007921" Oct 2 18:47:57.842273 ignition[1335]: INFO : op(3): [finished] unmounting "/mnt/oem914007921" Oct 2 18:47:57.842273 ignition[1335]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/eks/bootstrap.sh" Oct 2 18:47:57.842273 ignition[1335]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Oct 2 18:47:57.842273 ignition[1335]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Oct 2 18:47:57.866396 ignition[1335]: INFO : op(4): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem517605377" Oct 2 18:47:57.869908 ignition[1335]: CRITICAL : op(4): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem517605377": device or resource busy Oct 2 18:47:57.869908 ignition[1335]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem517605377", trying btrfs: device or resource busy Oct 2 18:47:57.869908 ignition[1335]: INFO : op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem517605377" Oct 2 18:47:57.881980 ignition[1335]: INFO : op(5): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem517605377" Oct 2 18:47:57.885811 ignition[1335]: INFO : op(6): [started] unmounting "/mnt/oem517605377" Oct 2 18:47:57.889110 ignition[1335]: INFO : op(6): [finished] unmounting "/mnt/oem517605377" Oct 2 18:47:57.889110 ignition[1335]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Oct 2 18:47:57.889110 ignition[1335]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Oct 2 18:47:57.889110 ignition[1335]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Oct 2 18:47:57.913243 ignition[1335]: INFO : op(7): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem998489675" Oct 2 18:47:57.916602 ignition[1335]: CRITICAL : op(7): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem998489675": device or resource busy Oct 2 18:47:57.916602 ignition[1335]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem998489675", trying btrfs: device or resource busy Oct 2 18:47:57.916602 ignition[1335]: INFO : op(8): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem998489675" Oct 2 18:47:57.928487 ignition[1335]: INFO : op(8): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem998489675" Oct 2 18:47:57.928487 ignition[1335]: INFO : op(9): [started] unmounting "/mnt/oem998489675" Oct 2 18:47:57.934715 ignition[1335]: INFO : op(9): [finished] unmounting "/mnt/oem998489675" Oct 2 18:47:57.937595 ignition[1335]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Oct 2 18:47:57.937595 ignition[1335]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" Oct 2 18:47:57.937595 ignition[1335]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Oct 2 18:47:57.963394 ignition[1335]: INFO : op(a): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2314561912" Oct 2 18:47:57.963394 ignition[1335]: CRITICAL : op(a): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2314561912": device or resource busy Oct 2 18:47:57.970930 ignition[1335]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2314561912", trying btrfs: device or resource busy Oct 2 18:47:57.970930 ignition[1335]: INFO : op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2314561912" Oct 2 18:47:57.970930 ignition[1335]: INFO : op(b): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2314561912" Oct 2 18:47:57.970930 ignition[1335]: INFO : op(c): [started] unmounting "/mnt/oem2314561912" Oct 2 18:47:57.985206 ignition[1335]: INFO : op(c): [finished] unmounting "/mnt/oem2314561912" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(7): [started] processing unit "amazon-ssm-agent.service" Oct 2 18:47:57.994531 ignition[1335]: 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:57.994531 ignition[1335]: 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:57.994531 ignition[1335]: INFO : files: op(7): [finished] processing unit "amazon-ssm-agent.service" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(9): [started] processing unit "nvidia.service" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(9): [finished] processing unit "nvidia.service" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(a): [started] processing unit "coreos-metadata-sshkeys@.service" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(a): [finished] processing unit "coreos-metadata-sshkeys@.service" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(b): [started] setting preset to enabled for "amazon-ssm-agent.service" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(b): [finished] setting preset to enabled for "amazon-ssm-agent.service" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(c): [started] setting preset to enabled for "nvidia.service" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(c): [finished] setting preset to enabled for "nvidia.service" Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(d): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service " Oct 2 18:47:57.994531 ignition[1335]: INFO : files: op(d): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service " Oct 2 18:47:58.069133 ignition[1335]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 2 18:47:58.073492 ignition[1335]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 2 18:47:58.077621 ignition[1335]: INFO : files: files passed Oct 2 18:47:58.077621 ignition[1335]: INFO : Ignition finished successfully Oct 2 18:47:58.083578 systemd[1]: Finished ignition-files.service. Oct 2 18:47:58.085000 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:58.097909 systemd[1]: Starting initrd-setup-root-after-ignition.service... Oct 2 18:47:58.100255 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Oct 2 18:47:58.101594 systemd[1]: Starting ignition-quench.service... Oct 2 18:47:58.122012 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 2 18:47:58.122232 systemd[1]: Finished ignition-quench.service. Oct 2 18:47:58.130000 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:58.130000 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:58.157795 initrd-setup-root-after-ignition[1360]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 2 18:47:58.163644 systemd[1]: Finished initrd-setup-root-after-ignition.service. Oct 2 18:47:58.165000 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:58.166432 systemd[1]: Reached target ignition-complete.target. Oct 2 18:47:58.169903 systemd[1]: Starting initrd-parse-etc.service... Oct 2 18:47:58.223294 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 2 18:47:58.223507 systemd[1]: Finished initrd-parse-etc.service. Oct 2 18:47:58.229000 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:58.229000 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:58.230693 systemd[1]: Reached target initrd-fs.target. Oct 2 18:47:58.234578 systemd[1]: Reached target initrd.target. Oct 2 18:47:58.236551 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Oct 2 18:47:58.237970 systemd[1]: Starting dracut-pre-pivot.service... Oct 2 18:47:58.283875 systemd[1]: Finished dracut-pre-pivot.service. Oct 2 18:47:58.286000 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:58.289193 systemd[1]: Starting initrd-cleanup.service... Oct 2 18:47:58.324612 systemd[1]: Stopped target nss-lookup.target. Oct 2 18:47:58.328788 systemd[1]: Stopped target remote-cryptsetup.target. Oct 2 18:47:58.334624 systemd[1]: Stopped target timers.target. Oct 2 18:47:58.338271 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 2 18:47:58.338404 systemd[1]: Stopped dracut-pre-pivot.service. Oct 2 18:47:58.343000 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:58.344837 systemd[1]: Stopped target initrd.target. Oct 2 18:47:58.348499 systemd[1]: Stopped target basic.target. Oct 2 18:47:58.352126 systemd[1]: Stopped target ignition-complete.target. Oct 2 18:47:58.356357 systemd[1]: Stopped target ignition-diskful.target. Oct 2 18:47:58.360540 systemd[1]: Stopped target initrd-root-device.target. Oct 2 18:47:58.364885 systemd[1]: Stopped target remote-fs.target. Oct 2 18:47:58.368667 systemd[1]: Stopped target remote-fs-pre.target. Oct 2 18:47:58.372699 systemd[1]: Stopped target sysinit.target. Oct 2 18:47:58.376387 systemd[1]: Stopped target local-fs.target. Oct 2 18:47:58.380126 systemd[1]: Stopped target local-fs-pre.target. Oct 2 18:47:58.384137 systemd[1]: Stopped target swap.target. Oct 2 18:47:58.387704 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 2 18:47:58.387822 systemd[1]: Stopped dracut-pre-mount.service. Oct 2 18:47:58.393000 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:58.394147 systemd[1]: Stopped target cryptsetup.target. Oct 2 18:47:58.398055 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 2 18:47:58.398162 systemd[1]: Stopped dracut-initqueue.service. Oct 2 18:47:58.403000 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:58.404558 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 2 18:47:58.404655 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Oct 2 18:47:58.411000 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:58.412314 systemd[1]: ignition-files.service: Deactivated successfully. Oct 2 18:47:58.412392 systemd[1]: Stopped ignition-files.service. Oct 2 18:47:58.415000 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:58.419682 systemd[1]: Stopping ignition-mount.service... Oct 2 18:47:58.444559 systemd[1]: Stopping iscsiuio.service... Oct 2 18:47:58.452131 ignition[1373]: INFO : Ignition 2.14.0 Oct 2 18:47:58.452131 ignition[1373]: INFO : Stage: umount Oct 2 18:47:58.455205 systemd[1]: Stopping sysroot-boot.service... Oct 2 18:47:58.456000 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:58.457000 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:58.469000 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:58.457323 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 2 18:47:58.457493 systemd[1]: Stopped systemd-udev-trigger.service. Oct 2 18:47:58.487000 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:58.487000 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:58.457916 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 2 18:47:58.457993 systemd[1]: Stopped dracut-pre-trigger.service. Oct 2 18:47:58.469829 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 2 18:47:58.497583 ignition[1373]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 18:47:58.497583 ignition[1373]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 18:47:58.470078 systemd[1]: Stopped iscsiuio.service. Oct 2 18:47:58.473751 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 2 18:47:58.474854 systemd[1]: Finished initrd-cleanup.service. Oct 2 18:47:58.511592 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 2 18:47:58.529874 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 2 18:47:58.531000 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:58.530085 systemd[1]: Stopped sysroot-boot.service. Oct 2 18:47:58.536784 ignition[1373]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 18:47:58.540121 ignition[1373]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 18:47:58.544695 ignition[1373]: INFO : PUT result: OK Oct 2 18:47:58.548871 ignition[1373]: INFO : umount: umount passed Oct 2 18:47:58.551351 ignition[1373]: INFO : Ignition finished successfully Oct 2 18:47:58.550995 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 2 18:47:58.551215 systemd[1]: Stopped ignition-mount.service. Oct 2 18:47:58.557000 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:58.558748 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 2 18:47:58.559000 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:58.561000 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:58.565000 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:58.558835 systemd[1]: Stopped ignition-disks.service. Oct 2 18:47:58.573000 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:58.560637 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 2 18:47:58.560714 systemd[1]: Stopped ignition-kargs.service. Oct 2 18:47:58.562470 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 2 18:47:58.562562 systemd[1]: Stopped ignition-fetch.service. Oct 2 18:47:58.566159 systemd[1]: Stopped target network.target. Oct 2 18:47:58.572552 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 2 18:47:58.572632 systemd[1]: Stopped ignition-fetch-offline.service. Oct 2 18:47:58.575636 systemd[1]: Stopped target paths.target. Oct 2 18:47:58.594757 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 2 18:47:58.598087 systemd[1]: Stopped systemd-ask-password-console.path. Oct 2 18:47:58.602550 systemd[1]: Stopped target slices.target. Oct 2 18:47:58.606221 systemd[1]: Stopped target sockets.target. Oct 2 18:47:58.609917 systemd[1]: iscsid.socket: Deactivated successfully. Oct 2 18:47:58.610094 systemd[1]: Closed iscsid.socket. Oct 2 18:47:58.615410 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 2 18:47:58.615581 systemd[1]: Closed iscsiuio.socket. Oct 2 18:47:58.620944 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 2 18:47:58.621508 systemd[1]: Stopped ignition-setup.service. Oct 2 18:47:58.626000 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:58.627354 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 2 18:47:58.627535 systemd[1]: Stopped initrd-setup-root.service. Oct 2 18:47:58.632000 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:58.634201 systemd[1]: Stopping systemd-networkd.service... Oct 2 18:47:58.638601 systemd[1]: Stopping systemd-resolved.service... Oct 2 18:47:58.645145 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 2 18:47:58.645856 systemd[1]: Stopped systemd-resolved.service. Oct 2 18:47:58.650000 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:58.654000 audit: BPF prog-id=6 op=UNLOAD Oct 2 18:47:58.659083 systemd-networkd[1180]: eth0: DHCPv6 lease lost Oct 2 18:47:58.663427 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 2 18:47:58.665981 systemd[1]: Stopped systemd-networkd.service. Oct 2 18:47:58.668000 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:58.670198 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 2 18:47:58.670286 systemd[1]: Closed systemd-networkd.socket. Oct 2 18:47:58.675902 systemd[1]: Stopping network-cleanup.service... Oct 2 18:47:58.684000 audit: BPF prog-id=9 op=UNLOAD Oct 2 18:47:58.685926 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 2 18:47:58.689000 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:58.693000 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:58.686083 systemd[1]: Stopped parse-ip-for-networkd.service. Oct 2 18:47:58.697000 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:58.691876 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 2 18:47:58.692240 systemd[1]: Stopped systemd-sysctl.service. Oct 2 18:47:58.694472 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 2 18:47:58.694573 systemd[1]: Stopped systemd-modules-load.service. Oct 2 18:47:58.705172 systemd[1]: Stopping systemd-udevd.service... Oct 2 18:47:58.709075 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Oct 2 18:47:58.732707 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 2 18:47:58.733013 systemd[1]: Stopped systemd-udevd.service. Oct 2 18:47:58.739000 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:58.741114 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 2 18:47:58.741428 systemd[1]: Stopped network-cleanup.service. Oct 2 18:47:58.745000 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:58.746893 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 2 18:47:58.747441 systemd[1]: Closed systemd-udevd-control.socket. Oct 2 18:47:58.752756 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 2 18:47:58.752927 systemd[1]: Closed systemd-udevd-kernel.socket. Oct 2 18:47:58.757371 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 2 18:47:58.762689 systemd[1]: Stopped dracut-pre-udev.service. Oct 2 18:47:58.765000 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:58.766503 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 2 18:47:58.766615 systemd[1]: Stopped dracut-cmdline.service. Oct 2 18:47:58.779000 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:58.780667 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 2 18:47:58.780747 systemd[1]: Stopped dracut-cmdline-ask.service. Oct 2 18:47:58.784000 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:58.788481 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Oct 2 18:47:58.806000 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:58.812000 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:58.802736 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 2 18:47:58.816000 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:58.821000 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:58.821000 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:58.802857 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service. Oct 2 18:47:58.807642 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 2 18:47:58.807731 systemd[1]: Stopped kmod-static-nodes.service. Oct 2 18:47:58.813747 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 2 18:47:58.813840 systemd[1]: Stopped systemd-vconsole-setup.service. Oct 2 18:47:58.818856 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Oct 2 18:47:58.819695 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 2 18:47:58.819875 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Oct 2 18:47:58.822667 systemd[1]: Reached target initrd-switch-root.target. Oct 2 18:47:58.828228 systemd[1]: Starting initrd-switch-root.service... Oct 2 18:47:58.851118 systemd[1]: Switching root. Oct 2 18:47:58.887890 iscsid[1190]: iscsid shutting down. Oct 2 18:47:58.889687 systemd-journald[309]: Received SIGTERM from PID 1 (n/a). Oct 2 18:47:58.889767 systemd-journald[309]: Journal stopped Oct 2 18:48:04.656167 kernel: SELinux: Class mctp_socket not defined in policy. Oct 2 18:48:04.656803 kernel: SELinux: Class anon_inode not defined in policy. Oct 2 18:48:04.656845 kernel: SELinux: the above unknown classes and permissions will be allowed Oct 2 18:48:04.656941 kernel: SELinux: policy capability network_peer_controls=1 Oct 2 18:48:04.656975 kernel: SELinux: policy capability open_perms=1 Oct 2 18:48:04.657006 kernel: SELinux: policy capability extended_socket_class=1 Oct 2 18:48:04.657055 kernel: SELinux: policy capability always_check_network=0 Oct 2 18:48:04.657089 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 2 18:48:04.657186 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 2 18:48:04.657220 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 2 18:48:04.657250 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 2 18:48:04.657286 systemd[1]: Successfully loaded SELinux policy in 93.186ms. Oct 2 18:48:04.657443 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 19.647ms. Oct 2 18:48:04.657482 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:04.657514 systemd[1]: Detected virtualization amazon. Oct 2 18:48:04.657609 systemd[1]: Detected architecture arm64. Oct 2 18:48:04.657643 systemd[1]: Detected first boot. Oct 2 18:48:04.657675 systemd[1]: Initializing machine ID from VM UUID. Oct 2 18:48:04.657704 systemd[1]: Populated /etc with preset unit settings. Oct 2 18:48:04.657741 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:04.657778 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:04.657812 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:04.657843 kernel: kauditd_printk_skb: 56 callbacks suppressed Oct 2 18:48:04.657870 kernel: audit: type=1334 audit(1696272484.066:84): prog-id=12 op=LOAD Oct 2 18:48:04.657904 kernel: audit: type=1334 audit(1696272484.068:85): prog-id=3 op=UNLOAD Oct 2 18:48:04.657937 kernel: audit: type=1334 audit(1696272484.071:86): prog-id=13 op=LOAD Oct 2 18:48:04.658044 kernel: audit: type=1334 audit(1696272484.073:87): prog-id=14 op=LOAD Oct 2 18:48:04.658078 systemd[1]: iscsid.service: Deactivated successfully. Oct 2 18:48:04.658110 kernel: audit: type=1334 audit(1696272484.073:88): prog-id=4 op=UNLOAD Oct 2 18:48:04.658138 systemd[1]: Stopped iscsid.service. Oct 2 18:48:04.658169 kernel: audit: type=1334 audit(1696272484.073:89): prog-id=5 op=UNLOAD Oct 2 18:48:04.658200 kernel: audit: type=1131 audit(1696272484.076: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:04.658230 kernel: audit: type=1334 audit(1696272484.085:91): prog-id=12 op=UNLOAD Oct 2 18:48:04.658264 kernel: audit: type=1131 audit(1696272484.100:92): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:04.658302 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 2 18:48:04.658816 systemd[1]: Stopped initrd-switch-root.service. Oct 2 18:48:04.669207 kernel: audit: type=1130 audit(1696272484.115: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:04.669272 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 2 18:48:04.669310 systemd[1]: Created slice system-addon\x2dconfig.slice. Oct 2 18:48:04.669343 systemd[1]: Created slice system-addon\x2drun.slice. Oct 2 18:48:04.669378 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice. Oct 2 18:48:04.669417 systemd[1]: Created slice system-getty.slice. Oct 2 18:48:04.669450 systemd[1]: Created slice system-modprobe.slice. Oct 2 18:48:04.669487 systemd[1]: Created slice system-serial\x2dgetty.slice. Oct 2 18:48:04.669518 systemd[1]: Created slice system-system\x2dcloudinit.slice. Oct 2 18:48:04.669551 systemd[1]: Created slice system-systemd\x2dfsck.slice. Oct 2 18:48:04.669582 systemd[1]: Created slice user.slice. Oct 2 18:48:04.669612 systemd[1]: Started systemd-ask-password-console.path. Oct 2 18:48:04.669642 systemd[1]: Started systemd-ask-password-wall.path. Oct 2 18:48:04.669675 systemd[1]: Set up automount boot.automount. Oct 2 18:48:04.669705 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Oct 2 18:48:04.669735 systemd[1]: Stopped target initrd-switch-root.target. Oct 2 18:48:04.669764 systemd[1]: Stopped target initrd-fs.target. Oct 2 18:48:04.669793 systemd[1]: Stopped target initrd-root-fs.target. Oct 2 18:48:04.669823 systemd[1]: Reached target integritysetup.target. Oct 2 18:48:04.669856 systemd[1]: Reached target remote-cryptsetup.target. Oct 2 18:48:04.669887 systemd[1]: Reached target remote-fs.target. Oct 2 18:48:04.669918 systemd[1]: Reached target slices.target. Oct 2 18:48:04.669948 systemd[1]: Reached target swap.target. Oct 2 18:48:04.669981 systemd[1]: Reached target torcx.target. Oct 2 18:48:04.670014 systemd[1]: Reached target veritysetup.target. Oct 2 18:48:04.670063 systemd[1]: Listening on systemd-coredump.socket. Oct 2 18:48:04.670096 systemd[1]: Listening on systemd-initctl.socket. Oct 2 18:48:04.670127 systemd[1]: Listening on systemd-networkd.socket. Oct 2 18:48:04.670159 systemd[1]: Listening on systemd-udevd-control.socket. Oct 2 18:48:04.670192 systemd[1]: Listening on systemd-udevd-kernel.socket. Oct 2 18:48:04.670224 systemd[1]: Listening on systemd-userdbd.socket. Oct 2 18:48:04.670256 systemd[1]: Mounting dev-hugepages.mount... Oct 2 18:48:04.670290 systemd[1]: Mounting dev-mqueue.mount... Oct 2 18:48:04.670322 systemd[1]: Mounting media.mount... Oct 2 18:48:04.670352 systemd[1]: Mounting sys-kernel-debug.mount... Oct 2 18:48:04.670384 systemd[1]: Mounting sys-kernel-tracing.mount... Oct 2 18:48:04.670414 systemd[1]: Mounting tmp.mount... Oct 2 18:48:04.670447 systemd[1]: Starting flatcar-tmpfiles.service... Oct 2 18:48:04.670495 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Oct 2 18:48:04.670534 systemd[1]: Starting kmod-static-nodes.service... Oct 2 18:48:04.670564 systemd[1]: Starting modprobe@configfs.service... Oct 2 18:48:04.670598 systemd[1]: Starting modprobe@dm_mod.service... Oct 2 18:48:04.670631 systemd[1]: Starting modprobe@drm.service... Oct 2 18:48:04.670663 systemd[1]: Starting modprobe@efi_pstore.service... Oct 2 18:48:04.670712 systemd[1]: Starting modprobe@fuse.service... Oct 2 18:48:04.670747 systemd[1]: Starting modprobe@loop.service... Oct 2 18:48:04.670778 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 2 18:48:04.670808 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 2 18:48:04.670838 systemd[1]: Stopped systemd-fsck-root.service. Oct 2 18:48:04.670868 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 2 18:48:04.670902 systemd[1]: Stopped systemd-fsck-usr.service. Oct 2 18:48:04.670933 systemd[1]: Stopped systemd-journald.service. Oct 2 18:48:04.670963 systemd[1]: Starting systemd-journald.service... Oct 2 18:48:04.670992 systemd[1]: Starting systemd-modules-load.service... Oct 2 18:48:04.671024 systemd[1]: Starting systemd-network-generator.service... Oct 2 18:48:04.679969 systemd[1]: Starting systemd-remount-fs.service... Oct 2 18:48:04.680004 systemd[1]: Starting systemd-udev-trigger.service... Oct 2 18:48:04.680062 systemd[1]: verity-setup.service: Deactivated successfully. Oct 2 18:48:04.680097 systemd[1]: Stopped verity-setup.service. Oct 2 18:48:04.680133 systemd[1]: Mounted dev-hugepages.mount. Oct 2 18:48:04.680169 systemd[1]: Mounted dev-mqueue.mount. Oct 2 18:48:04.680204 systemd[1]: Mounted media.mount. Oct 2 18:48:04.680236 systemd[1]: Mounted sys-kernel-debug.mount. Oct 2 18:48:04.680266 systemd[1]: Mounted sys-kernel-tracing.mount. Oct 2 18:48:04.680296 systemd[1]: Mounted tmp.mount. Oct 2 18:48:04.680326 systemd[1]: Finished kmod-static-nodes.service. Oct 2 18:48:04.680358 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 2 18:48:04.680389 systemd[1]: Finished modprobe@configfs.service. Oct 2 18:48:04.680423 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 2 18:48:04.680457 systemd[1]: Finished modprobe@dm_mod.service. Oct 2 18:48:04.680488 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 2 18:48:04.680518 systemd[1]: Finished modprobe@drm.service. Oct 2 18:48:04.680549 systemd[1]: Mounting sys-kernel-config.mount... Oct 2 18:48:04.680584 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 2 18:48:04.680615 systemd[1]: Finished modprobe@efi_pstore.service. Oct 2 18:48:04.680647 systemd[1]: Finished systemd-remount-fs.service. Oct 2 18:48:04.680676 systemd[1]: Finished systemd-network-generator.service. Oct 2 18:48:04.680708 systemd[1]: Finished systemd-modules-load.service. Oct 2 18:48:04.680745 systemd[1]: Mounted sys-kernel-config.mount. Oct 2 18:48:04.680775 kernel: loop: module loaded Oct 2 18:48:04.680806 systemd[1]: Reached target network-pre.target. Oct 2 18:48:04.680841 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 2 18:48:04.680880 kernel: fuse: init (API version 7.34) Oct 2 18:48:04.680910 systemd[1]: Starting systemd-hwdb-update.service... Oct 2 18:48:04.680941 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 2 18:48:04.680971 systemd[1]: Starting systemd-random-seed.service... Oct 2 18:48:04.681003 systemd[1]: Starting systemd-sysctl.service... Oct 2 18:48:04.681064 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 2 18:48:04.681099 systemd[1]: Finished modprobe@fuse.service. Oct 2 18:48:04.681130 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 2 18:48:04.681163 systemd[1]: Finished modprobe@loop.service. Oct 2 18:48:04.681193 systemd[1]: Mounting sys-fs-fuse-connections.mount... Oct 2 18:48:04.681223 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Oct 2 18:48:04.681254 systemd[1]: Mounted sys-fs-fuse-connections.mount. Oct 2 18:48:04.681287 systemd-journald[1482]: Journal started Oct 2 18:48:04.681397 systemd-journald[1482]: Runtime Journal (/run/log/journal/ec2d62918ff14c77d2d504ffd4bf58b7) is 8.0M, max 75.4M, 67.4M free. Oct 2 18:47:59.706000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 2 18:47:59.922000 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:59.922000 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:59.922000 audit: BPF prog-id=10 op=LOAD Oct 2 18:47:59.922000 audit: BPF prog-id=10 op=UNLOAD Oct 2 18:47:59.923000 audit: BPF prog-id=11 op=LOAD Oct 2 18:47:59.923000 audit: BPF prog-id=11 op=UNLOAD Oct 2 18:48:04.066000 audit: BPF prog-id=12 op=LOAD Oct 2 18:48:04.068000 audit: BPF prog-id=3 op=UNLOAD Oct 2 18:48:04.071000 audit: BPF prog-id=13 op=LOAD Oct 2 18:48:04.073000 audit: BPF prog-id=14 op=LOAD Oct 2 18:48:04.073000 audit: BPF prog-id=4 op=UNLOAD Oct 2 18:48:04.073000 audit: BPF prog-id=5 op=UNLOAD Oct 2 18:48:04.076000 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:04.085000 audit: BPF prog-id=12 op=UNLOAD Oct 2 18:48:04.100000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:04.115000 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:04.115000 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:04.396000 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:04.405000 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:04.410000 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:04.410000 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:04.411000 audit: BPF prog-id=15 op=LOAD Oct 2 18:48:04.411000 audit: BPF prog-id=16 op=LOAD Oct 2 18:48:04.412000 audit: BPF prog-id=17 op=LOAD Oct 2 18:48:04.412000 audit: BPF prog-id=13 op=UNLOAD Oct 2 18:48:04.412000 audit: BPF prog-id=14 op=UNLOAD Oct 2 18:48:04.460000 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:04.494000 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:04.502000 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:04.688400 systemd[1]: Started systemd-journald.service. Oct 2 18:48:04.502000 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:04.512000 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:04.512000 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:04.519000 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:04.519000 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:04.547000 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:04.547000 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:04.552000 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:04.560000 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:04.565000 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:04.621000 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:04.621000 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:04.624000 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:04.624000 audit[1482]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=6 a1=ffffd7b881d0 a2=4000 a3=1 items=0 ppid=1 pid=1482 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:04.624000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 2 18:48:04.628000 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:04.628000 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:04.686000 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:00.115495 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" 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.063790 systemd[1]: Queued start job for default target multi-user.target. Oct 2 18:48:00.129218 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 2 18:48:04.077928 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 2 18:48:00.129294 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 2 18:48:04.688260 systemd[1]: Finished systemd-random-seed.service. Oct 2 18:48:00.129387 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 2 18:48:00.129437 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 2 18:48:00.129530 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 2 18:48:00.129562 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 2 18:48:00.130148 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 2 18:48:00.130256 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" 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.130315 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 2 18:48:00.131421 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" 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:48:04.691000 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:48:00.131530 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" 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:48:04.693364 systemd[1]: Reached target first-boot-complete.target. Oct 2 18:48:00.131602 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" 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:48:04.699905 systemd[1]: Starting systemd-journal-flush.service... Oct 2 18:48:00.131645 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" 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:48:00.131718 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" 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:48:00.131782 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:00Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 2 18:48:03.246469 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:03Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 2 18:48:03.247014 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:03Z" 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:03.247272 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:03Z" 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:03.247701 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:03Z" 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:03.247807 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:03Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 2 18:48:03.247939 /usr/lib/systemd/system-generators/torcx-generator[1407]: time="2023-10-02T18:48:03Z" 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:04.751263 systemd[1]: Finished systemd-sysctl.service. Oct 2 18:48:04.754413 systemd-journald[1482]: Time spent on flushing to /var/log/journal/ec2d62918ff14c77d2d504ffd4bf58b7 is 60.260ms for 1090 entries. Oct 2 18:48:04.754413 systemd-journald[1482]: System Journal (/var/log/journal/ec2d62918ff14c77d2d504ffd4bf58b7) is 8.0M, max 195.6M, 187.6M free. Oct 2 18:48:04.842592 systemd-journald[1482]: Received client request to flush runtime journal. Oct 2 18:48:04.757000 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:04.845319 systemd[1]: Finished systemd-journal-flush.service. Oct 2 18:48:04.848000 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:04.867230 systemd[1]: Finished systemd-udev-trigger.service. Oct 2 18:48:04.870000 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:48:04.873750 systemd[1]: Starting systemd-udev-settle.service... Oct 2 18:48:04.900917 systemd[1]: Finished flatcar-tmpfiles.service. Oct 2 18:48:04.904000 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:04.911273 systemd[1]: Starting systemd-sysusers.service... Oct 2 18:48:04.918178 udevadm[1520]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 2 18:48:05.011903 systemd[1]: Finished systemd-sysusers.service. Oct 2 18:48:05.015000 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:05.018459 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Oct 2 18:48:05.158289 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Oct 2 18:48:05.161000 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:05.641281 systemd[1]: Finished systemd-hwdb-update.service. Oct 2 18:48:05.643000 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:05.644000 audit: BPF prog-id=18 op=LOAD Oct 2 18:48:05.644000 audit: BPF prog-id=19 op=LOAD Oct 2 18:48:05.644000 audit: BPF prog-id=7 op=UNLOAD Oct 2 18:48:05.644000 audit: BPF prog-id=8 op=UNLOAD Oct 2 18:48:05.646698 systemd[1]: Starting systemd-udevd.service... Oct 2 18:48:05.694552 systemd-udevd[1529]: Using default interface naming scheme 'v252'. Oct 2 18:48:05.742759 systemd[1]: Started systemd-udevd.service. Oct 2 18:48:05.750000 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:05.752000 audit: BPF prog-id=20 op=LOAD Oct 2 18:48:05.757306 systemd[1]: Starting systemd-networkd.service... Oct 2 18:48:05.780000 audit: BPF prog-id=21 op=LOAD Oct 2 18:48:05.780000 audit: BPF prog-id=22 op=LOAD Oct 2 18:48:05.780000 audit: BPF prog-id=23 op=LOAD Oct 2 18:48:05.782695 systemd[1]: Starting systemd-userdbd.service... Oct 2 18:48:05.892000 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:05.888912 systemd[1]: Started systemd-userdbd.service. Oct 2 18:48:05.893303 systemd[1]: Condition check resulted in dev-ttyS0.device being skipped. Oct 2 18:48:05.959572 (udev-worker)[1537]: Network interface NamePolicy= disabled on kernel command line. Oct 2 18:48:06.087077 systemd-networkd[1542]: lo: Link UP Oct 2 18:48:06.091000 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:06.087561 systemd-networkd[1542]: lo: Gained carrier Oct 2 18:48:06.088523 systemd-networkd[1542]: Enumeration completed Oct 2 18:48:06.088680 systemd[1]: Started systemd-networkd.service. Oct 2 18:48:06.095144 systemd[1]: Starting systemd-networkd-wait-online.service... Oct 2 18:48:06.104276 systemd-networkd[1542]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 2 18:48:06.110061 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 2 18:48:06.110301 systemd-networkd[1542]: eth0: Link UP Oct 2 18:48:06.110772 systemd-networkd[1542]: eth0: Gained carrier Oct 2 18:48:06.131353 systemd-networkd[1542]: eth0: DHCPv4 address 172.31.22.29/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 2 18:48:06.200115 kernel: BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/nvme0n1p6 scanned by (udev-worker) (1540) Oct 2 18:48:06.407164 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Oct 2 18:48:06.415738 systemd[1]: Finished systemd-udev-settle.service. Oct 2 18:48:06.417000 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:06.420666 systemd[1]: Starting lvm2-activation-early.service... Oct 2 18:48:06.491936 lvm[1647]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 2 18:48:06.529925 systemd[1]: Finished lvm2-activation-early.service. Oct 2 18:48:06.531000 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:06.532789 systemd[1]: Reached target cryptsetup.target. Oct 2 18:48:06.537298 systemd[1]: Starting lvm2-activation.service... Oct 2 18:48:06.550650 lvm[1648]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 2 18:48:06.584905 systemd[1]: Finished lvm2-activation.service. Oct 2 18:48:06.586000 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:06.587519 systemd[1]: Reached target local-fs-pre.target. Oct 2 18:48:06.590174 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Oct 2 18:48:06.590216 systemd[1]: Reached target local-fs.target. Oct 2 18:48:06.593308 systemd[1]: Reached target machines.target. Oct 2 18:48:06.597446 systemd[1]: Starting ldconfig.service... Oct 2 18:48:06.599638 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Oct 2 18:48:06.599766 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:06.601940 systemd[1]: Starting systemd-boot-update.service... Oct 2 18:48:06.608201 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Oct 2 18:48:06.615216 systemd[1]: Starting systemd-machine-id-commit.service... Oct 2 18:48:06.619318 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Oct 2 18:48:06.619446 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Oct 2 18:48:06.621714 systemd[1]: Starting systemd-tmpfiles-setup.service... Oct 2 18:48:06.654839 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1650 (bootctl) Oct 2 18:48:06.657292 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Oct 2 18:48:06.687401 systemd-tmpfiles[1653]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 2 18:48:06.690567 systemd-tmpfiles[1653]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 2 18:48:06.695398 systemd-tmpfiles[1653]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 2 18:48:06.713283 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Oct 2 18:48:06.712000 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:06.734394 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 2 18:48:06.734000 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:06.735489 systemd[1]: Finished systemd-machine-id-commit.service. Oct 2 18:48:06.781701 systemd-fsck[1658]: fsck.fat 4.2 (2021-01-31) Oct 2 18:48:06.781701 systemd-fsck[1658]: /dev/nvme0n1p1: 236 files, 113463/258078 clusters Oct 2 18:48:06.787024 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Oct 2 18:48:06.788000 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:06.792390 systemd[1]: Mounting boot.mount... Oct 2 18:48:06.831337 systemd[1]: Mounted boot.mount. Oct 2 18:48:06.859064 systemd[1]: Finished systemd-boot-update.service. Oct 2 18:48:06.862000 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:07.036000 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:07.035042 systemd[1]: Finished systemd-tmpfiles-setup.service. Oct 2 18:48:07.039828 systemd[1]: Starting audit-rules.service... Oct 2 18:48:07.046532 systemd[1]: Starting clean-ca-certificates.service... Oct 2 18:48:07.051024 systemd[1]: Starting systemd-journal-catalog-update.service... Oct 2 18:48:07.055000 audit: BPF prog-id=24 op=LOAD Oct 2 18:48:07.062698 systemd[1]: Starting systemd-resolved.service... Oct 2 18:48:07.065000 audit: BPF prog-id=25 op=LOAD Oct 2 18:48:07.067898 systemd[1]: Starting systemd-timesyncd.service... Oct 2 18:48:07.075334 systemd[1]: Starting systemd-update-utmp.service... Oct 2 18:48:07.101456 systemd[1]: Finished clean-ca-certificates.service. Oct 2 18:48:07.102000 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:07.103948 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:07.111000 audit[1677]: SYSTEM_BOOT pid=1677 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:07.119173 systemd[1]: Finished systemd-update-utmp.service. Oct 2 18:48:07.120000 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:07.159240 systemd-networkd[1542]: eth0: Gained IPv6LL Oct 2 18:48:07.163744 systemd[1]: Finished systemd-journal-catalog-update.service. Oct 2 18:48:07.165000 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:07.167935 systemd[1]: Finished systemd-networkd-wait-online.service. Oct 2 18:48:07.169000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:07.272000 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:07.269743 systemd[1]: Started systemd-timesyncd.service. Oct 2 18:48:07.273885 systemd[1]: Reached target time-set.target. Oct 2 18:48:07.276989 systemd-resolved[1675]: Positive Trust Anchors: Oct 2 18:48:07.277528 systemd-resolved[1675]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 2 18:48:07.278301 systemd-resolved[1675]: 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:07.321303 systemd-resolved[1675]: Defaulting to hostname 'linux'. Oct 2 18:48:07.324992 systemd[1]: Started systemd-resolved.service. Oct 2 18:48:07.326000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:07.328010 systemd[1]: Reached target network.target. Oct 2 18:48:07.330747 systemd[1]: Reached target network-online.target. Oct 2 18:48:07.333126 systemd[1]: Reached target nss-lookup.target. Oct 2 18:48:07.340582 augenrules[1693]: No rules Oct 2 18:48:07.339000 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:07.339000 audit[1693]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffffd5bf520 a2=420 a3=0 items=0 ppid=1672 pid=1693 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:07.339000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 2 18:48:07.342233 systemd[1]: Finished audit-rules.service. Oct 2 18:48:07.762128 systemd-resolved[1675]: Clock change detected. Flushing caches. Oct 2 18:48:07.762129 systemd-timesyncd[1676]: Contacted time server 204.17.205.8:123 (0.flatcar.pool.ntp.org). Oct 2 18:48:07.762245 systemd-timesyncd[1676]: Initial clock synchronization to Mon 2023-10-02 18:48:07.761944 UTC. Oct 2 18:48:07.893770 ldconfig[1649]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 2 18:48:07.910300 systemd[1]: Finished ldconfig.service. Oct 2 18:48:07.915238 systemd[1]: Starting systemd-update-done.service... Oct 2 18:48:07.937721 systemd[1]: Finished systemd-update-done.service. Oct 2 18:48:07.940202 systemd[1]: Reached target sysinit.target. Oct 2 18:48:07.942351 systemd[1]: Started motdgen.path. Oct 2 18:48:07.944130 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Oct 2 18:48:07.947132 systemd[1]: Started logrotate.timer. Oct 2 18:48:07.949157 systemd[1]: Started mdadm.timer. Oct 2 18:48:07.950832 systemd[1]: Started systemd-tmpfiles-clean.timer. Oct 2 18:48:07.953018 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 2 18:48:07.953071 systemd[1]: Reached target paths.target. Oct 2 18:48:07.954899 systemd[1]: Reached target timers.target. Oct 2 18:48:07.957527 systemd[1]: Listening on dbus.socket. Oct 2 18:48:07.961382 systemd[1]: Starting docker.socket... Oct 2 18:48:07.972036 systemd[1]: Listening on sshd.socket. Oct 2 18:48:07.974162 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:07.975045 systemd[1]: Listening on docker.socket. Oct 2 18:48:07.977154 systemd[1]: Reached target sockets.target. Oct 2 18:48:07.979180 systemd[1]: Reached target basic.target. Oct 2 18:48:07.981132 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Oct 2 18:48:07.981195 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Oct 2 18:48:07.983355 systemd[1]: Started amazon-ssm-agent.service. Oct 2 18:48:07.987793 systemd[1]: Starting containerd.service... Oct 2 18:48:07.992386 systemd[1]: Starting coreos-metadata-sshkeys@core.service... Oct 2 18:48:07.998434 systemd[1]: Starting dbus.service... Oct 2 18:48:08.003363 systemd[1]: Starting enable-oem-cloudinit.service... Oct 2 18:48:08.009007 systemd[1]: Starting extend-filesystems.service... Oct 2 18:48:08.011021 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:08.018546 systemd[1]: Starting motdgen.service... Oct 2 18:48:08.022966 systemd[1]: Started nvidia.service. Oct 2 18:48:08.040346 systemd[1]: Starting ssh-key-proc-cmdline.service... Oct 2 18:48:08.046568 systemd[1]: Starting sshd-keygen.service... Oct 2 18:48:08.069958 systemd[1]: Starting systemd-logind.service... Oct 2 18:48:08.072013 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:08.234941 jq[1714]: true Oct 2 18:48:08.235211 jq[1705]: false Oct 2 18:48:08.072149 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 2 18:48:08.073001 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 2 18:48:08.076916 systemd[1]: Starting update-engine.service... Oct 2 18:48:08.080887 systemd[1]: Starting update-ssh-keys-after-ignition.service... Oct 2 18:48:08.096326 systemd[1]: Created slice system-sshd.slice. Oct 2 18:48:08.185247 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 2 18:48:08.185606 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Oct 2 18:48:08.202967 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 2 18:48:08.203293 systemd[1]: Finished ssh-key-proc-cmdline.service. Oct 2 18:48:08.271377 jq[1723]: true Oct 2 18:48:08.305608 extend-filesystems[1706]: Found nvme0n1 Oct 2 18:48:08.305608 extend-filesystems[1706]: Found nvme0n1p1 Oct 2 18:48:08.305608 extend-filesystems[1706]: Found nvme0n1p2 Oct 2 18:48:08.305608 extend-filesystems[1706]: Found nvme0n1p3 Oct 2 18:48:08.305608 extend-filesystems[1706]: Found usr Oct 2 18:48:08.305608 extend-filesystems[1706]: Found nvme0n1p4 Oct 2 18:48:08.305608 extend-filesystems[1706]: Found nvme0n1p6 Oct 2 18:48:08.305608 extend-filesystems[1706]: Found nvme0n1p7 Oct 2 18:48:08.336041 extend-filesystems[1706]: Found nvme0n1p9 Oct 2 18:48:08.336041 extend-filesystems[1706]: Checking size of /dev/nvme0n1p9 Oct 2 18:48:08.375303 dbus-daemon[1704]: [system] SELinux support is enabled Oct 2 18:48:08.375625 systemd[1]: Started dbus.service. Oct 2 18:48:08.392771 dbus-daemon[1704]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.2' (uid=244 pid=1542 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Oct 2 18:48:08.382599 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:08.382645 systemd[1]: Reached target system-config.target. Oct 2 18:48:08.387016 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Oct 2 18:48:08.387067 systemd[1]: Reached target user-config.target. Oct 2 18:48:08.399189 systemd[1]: Starting systemd-hostnamed.service... Oct 2 18:48:08.463781 systemd[1]: motdgen.service: Deactivated successfully. Oct 2 18:48:08.464174 systemd[1]: Finished motdgen.service. Oct 2 18:48:08.489829 update_engine[1713]: I1002 18:48:08.489166 1713 main.cc:92] Flatcar Update Engine starting Oct 2 18:48:08.492752 extend-filesystems[1706]: Resized partition /dev/nvme0n1p9 Oct 2 18:48:08.501414 systemd[1]: Started update-engine.service. Oct 2 18:48:08.516883 update_engine[1713]: I1002 18:48:08.513142 1713 update_check_scheduler.cc:74] Next update check in 8m59s Oct 2 18:48:08.508318 systemd[1]: Started locksmithd.service. Oct 2 18:48:08.518494 amazon-ssm-agent[1701]: 2023/10/02 18:48:08 Failed to load instance info from vault. RegistrationKey does not exist. Oct 2 18:48:08.523000 extend-filesystems[1761]: resize2fs 1.46.5 (30-Dec-2021) Oct 2 18:48:08.527900 amazon-ssm-agent[1701]: Initializing new seelog logger Oct 2 18:48:08.527900 amazon-ssm-agent[1701]: New Seelog Logger Creation Complete Oct 2 18:48:08.527900 amazon-ssm-agent[1701]: 2023/10/02 18:48:08 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 2 18:48:08.527900 amazon-ssm-agent[1701]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 2 18:48:08.527900 amazon-ssm-agent[1701]: 2023/10/02 18:48:08 processing appconfig overrides Oct 2 18:48:08.555783 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Oct 2 18:48:08.612300 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Oct 2 18:48:08.645304 systemd-logind[1712]: Watching system buttons on /dev/input/event0 (Power Button) Oct 2 18:48:08.646944 systemd-logind[1712]: New seat seat0. Oct 2 18:48:08.648072 env[1726]: time="2023-10-02T18:48:08.647293905Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Oct 2 18:48:08.648450 extend-filesystems[1761]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Oct 2 18:48:08.648450 extend-filesystems[1761]: old_desc_blocks = 1, new_desc_blocks = 1 Oct 2 18:48:08.648450 extend-filesystems[1761]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Oct 2 18:48:08.685155 extend-filesystems[1706]: Resized filesystem in /dev/nvme0n1p9 Oct 2 18:48:08.657904 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 2 18:48:08.658283 systemd[1]: Finished extend-filesystems.service. Oct 2 18:48:08.680302 systemd[1]: Started systemd-logind.service. Oct 2 18:48:08.691379 bash[1782]: Updated "/home/core/.ssh/authorized_keys" Oct 2 18:48:08.692605 systemd[1]: Finished update-ssh-keys-after-ignition.service. Oct 2 18:48:08.720456 systemd[1]: nvidia.service: Deactivated successfully. Oct 2 18:48:08.865150 env[1726]: time="2023-10-02T18:48:08.864670042Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 2 18:48:08.865687 env[1726]: time="2023-10-02T18:48:08.865561882Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 2 18:48:08.877275 env[1726]: time="2023-10-02T18:48:08.877157326Z" 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:08.877275 env[1726]: time="2023-10-02T18:48:08.877264714Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 2 18:48:08.923407 env[1726]: time="2023-10-02T18:48:08.923333566Z" 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:08.923407 env[1726]: time="2023-10-02T18:48:08.923396062Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 2 18:48:08.923613 env[1726]: time="2023-10-02T18:48:08.923431594Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 2 18:48:08.923613 env[1726]: time="2023-10-02T18:48:08.923456998Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 2 18:48:08.923744 env[1726]: time="2023-10-02T18:48:08.923702674Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 2 18:48:08.924425 env[1726]: time="2023-10-02T18:48:08.924364606Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 2 18:48:08.924822 env[1726]: time="2023-10-02T18:48:08.924735742Z" 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:08.924822 env[1726]: time="2023-10-02T18:48:08.924782962Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 2 18:48:08.925082 env[1726]: time="2023-10-02T18:48:08.924965434Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 2 18:48:08.925082 env[1726]: time="2023-10-02T18:48:08.925027066Z" level=info msg="metadata content store policy set" policy=shared Oct 2 18:48:08.940317 env[1726]: time="2023-10-02T18:48:08.940253122Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 2 18:48:08.940465 env[1726]: time="2023-10-02T18:48:08.940354510Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 2 18:48:08.940465 env[1726]: time="2023-10-02T18:48:08.940399306Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 2 18:48:08.940603 env[1726]: time="2023-10-02T18:48:08.940480294Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 2 18:48:08.940838 env[1726]: time="2023-10-02T18:48:08.940795882Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 2 18:48:08.940909 env[1726]: time="2023-10-02T18:48:08.940845406Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 2 18:48:08.940909 env[1726]: time="2023-10-02T18:48:08.940878598Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 2 18:48:08.941479 env[1726]: time="2023-10-02T18:48:08.941419834Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 2 18:48:08.941569 env[1726]: time="2023-10-02T18:48:08.941480002Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Oct 2 18:48:08.941569 env[1726]: time="2023-10-02T18:48:08.941514826Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 2 18:48:08.941569 env[1726]: time="2023-10-02T18:48:08.941545534Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 2 18:48:08.941769 env[1726]: time="2023-10-02T18:48:08.941577694Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 2 18:48:08.941866 env[1726]: time="2023-10-02T18:48:08.941823538Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 2 18:48:08.942071 env[1726]: time="2023-10-02T18:48:08.942027466Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 2 18:48:08.942942 env[1726]: time="2023-10-02T18:48:08.942889666Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 2 18:48:08.943067 env[1726]: time="2023-10-02T18:48:08.942958594Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.943067 env[1726]: time="2023-10-02T18:48:08.942992650Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 2 18:48:08.943215 env[1726]: time="2023-10-02T18:48:08.943174438Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.943461 env[1726]: time="2023-10-02T18:48:08.943418554Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.943531 env[1726]: time="2023-10-02T18:48:08.943464370Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.943531 env[1726]: time="2023-10-02T18:48:08.943495834Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.943656 env[1726]: time="2023-10-02T18:48:08.943527286Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.943656 env[1726]: time="2023-10-02T18:48:08.943558522Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.943656 env[1726]: time="2023-10-02T18:48:08.943608034Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.943656 env[1726]: time="2023-10-02T18:48:08.943640674Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.943877 env[1726]: time="2023-10-02T18:48:08.943674622Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 2 18:48:08.944042 env[1726]: time="2023-10-02T18:48:08.943955674Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.944042 env[1726]: time="2023-10-02T18:48:08.943990438Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.944152 env[1726]: time="2023-10-02T18:48:08.944043730Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.944152 env[1726]: time="2023-10-02T18:48:08.944076010Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 2 18:48:08.944152 env[1726]: time="2023-10-02T18:48:08.944112538Z" 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:08.944152 env[1726]: time="2023-10-02T18:48:08.944139946Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 2 18:48:08.944349 env[1726]: time="2023-10-02T18:48:08.944176474Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Oct 2 18:48:08.944349 env[1726]: time="2023-10-02T18:48:08.944240014Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 2 18:48:08.944792 env[1726]: time="2023-10-02T18:48:08.944680978Z" 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:08.946094 env[1726]: time="2023-10-02T18:48:08.944797498Z" level=info msg="Connect containerd service" Oct 2 18:48:08.946094 env[1726]: time="2023-10-02T18:48:08.944856646Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 2 18:48:08.947805 env[1726]: time="2023-10-02T18:48:08.947271310Z" 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:08.948451 env[1726]: time="2023-10-02T18:48:08.948394402Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 2 18:48:08.948549 env[1726]: time="2023-10-02T18:48:08.948509134Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 2 18:48:08.952928 env[1726]: time="2023-10-02T18:48:08.952554802Z" level=info msg="containerd successfully booted in 0.327448s" Oct 2 18:48:08.948718 systemd[1]: Started containerd.service. Oct 2 18:48:08.956436 env[1726]: time="2023-10-02T18:48:08.954769762Z" level=info msg="Start subscribing containerd event" Oct 2 18:48:08.956436 env[1726]: time="2023-10-02T18:48:08.954883414Z" level=info msg="Start recovering state" Oct 2 18:48:08.956436 env[1726]: time="2023-10-02T18:48:08.955200118Z" level=info msg="Start event monitor" Oct 2 18:48:08.956436 env[1726]: time="2023-10-02T18:48:08.955361974Z" level=info msg="Start snapshots syncer" Oct 2 18:48:08.956436 env[1726]: time="2023-10-02T18:48:08.955391938Z" level=info msg="Start cni network conf syncer for default" Oct 2 18:48:08.956436 env[1726]: time="2023-10-02T18:48:08.955573906Z" level=info msg="Start streaming server" Oct 2 18:48:09.067485 coreos-metadata[1703]: Oct 02 18:48:09.067 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 2 18:48:09.069303 coreos-metadata[1703]: Oct 02 18:48:09.069 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys: Attempt #1 Oct 2 18:48:09.071697 coreos-metadata[1703]: Oct 02 18:48:09.071 INFO Fetch successful Oct 2 18:48:09.071829 coreos-metadata[1703]: Oct 02 18:48:09.071 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys/0/openssh-key: Attempt #1 Oct 2 18:48:09.072771 coreos-metadata[1703]: Oct 02 18:48:09.072 INFO Fetch successful Oct 2 18:48:09.075391 unknown[1703]: wrote ssh authorized keys file for user: core Oct 2 18:48:09.104682 update-ssh-keys[1845]: Updated "/home/core/.ssh/authorized_keys" Oct 2 18:48:09.105862 systemd[1]: Finished coreos-metadata-sshkeys@core.service. Oct 2 18:48:09.213610 dbus-daemon[1704]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 2 18:48:09.214290 dbus-daemon[1704]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1747 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Oct 2 18:48:09.225350 amazon-ssm-agent[1701]: 2023-10-02 18:48:09 INFO Entering SSM Agent hibernate - AccessDeniedException: User: arn:aws:sts::075585003325:assumed-role/jenkins-test/i-09d82bb4247e52e87 is not authorized to perform: ssm:UpdateInstanceInformation on resource: arn:aws:ec2:us-west-2:075585003325:instance/i-09d82bb4247e52e87 because no identity-based policy allows the ssm:UpdateInstanceInformation action Oct 2 18:48:09.225350 amazon-ssm-agent[1701]: status code: 400, request id: db90f087-ce97-439d-ba8d-0c62aca719f0 Oct 2 18:48:09.225350 amazon-ssm-agent[1701]: 2023-10-02 18:48:09 INFO Agent is in hibernate mode. Reducing logging. Logging will be reduced to one log per backoff period Oct 2 18:48:09.213861 systemd[1]: Started systemd-hostnamed.service. Oct 2 18:48:09.229226 systemd[1]: Starting polkit.service... Oct 2 18:48:09.280575 polkitd[1859]: Started polkitd version 121 Oct 2 18:48:09.305162 polkitd[1859]: Loading rules from directory /etc/polkit-1/rules.d Oct 2 18:48:09.305277 polkitd[1859]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 2 18:48:09.309558 polkitd[1859]: Finished loading, compiling and executing 2 rules Oct 2 18:48:09.310271 dbus-daemon[1704]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 2 18:48:09.310534 systemd[1]: Started polkit.service. Oct 2 18:48:09.310996 polkitd[1859]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 2 18:48:09.338735 systemd-hostnamed[1747]: Hostname set to (transient) Oct 2 18:48:09.338887 systemd-resolved[1675]: System hostname changed to 'ip-172-31-22-29'. Oct 2 18:48:09.533473 locksmithd[1763]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 2 18:48:12.608085 sshd_keygen[1736]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 2 18:48:12.665067 systemd[1]: Finished sshd-keygen.service. Oct 2 18:48:12.670469 systemd[1]: Starting issuegen.service... Oct 2 18:48:12.674952 systemd[1]: Started sshd@0-172.31.22.29:22-139.178.89.65:50006.service. Oct 2 18:48:12.694766 systemd[1]: issuegen.service: Deactivated successfully. Oct 2 18:48:12.695115 systemd[1]: Finished issuegen.service. Oct 2 18:48:12.699913 systemd[1]: Starting systemd-user-sessions.service... Oct 2 18:48:12.723178 systemd[1]: Finished systemd-user-sessions.service. Oct 2 18:48:12.728516 systemd[1]: Started getty@tty1.service. Oct 2 18:48:12.734685 systemd[1]: Started serial-getty@ttyS0.service. Oct 2 18:48:12.738528 systemd[1]: Reached target getty.target. Oct 2 18:48:12.740963 systemd[1]: Reached target multi-user.target. Oct 2 18:48:12.747420 systemd[1]: Starting systemd-update-utmp-runlevel.service... Oct 2 18:48:12.773763 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 2 18:48:12.774102 systemd[1]: Finished systemd-update-utmp-runlevel.service. Oct 2 18:48:12.777037 systemd[1]: Startup finished in 1.177s (kernel) + 7.962s (initrd) + 12.808s (userspace) = 21.947s. Oct 2 18:48:12.949812 sshd[1899]: Accepted publickey for core from 139.178.89.65 port 50006 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8 Oct 2 18:48:12.954181 sshd[1899]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 18:48:12.971526 systemd[1]: Created slice user-500.slice. Oct 2 18:48:12.974379 systemd[1]: Starting user-runtime-dir@500.service... Oct 2 18:48:12.981706 systemd-logind[1712]: New session 1 of user core. Oct 2 18:48:13.000769 systemd[1]: Finished user-runtime-dir@500.service. Oct 2 18:48:13.004498 systemd[1]: Starting user@500.service... Oct 2 18:48:13.015766 (systemd)[1908]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 2 18:48:13.224278 systemd[1908]: Queued start job for default target default.target. Oct 2 18:48:13.225300 systemd[1908]: Reached target paths.target. Oct 2 18:48:13.225352 systemd[1908]: Reached target sockets.target. Oct 2 18:48:13.225384 systemd[1908]: Reached target timers.target. Oct 2 18:48:13.225414 systemd[1908]: Reached target basic.target. Oct 2 18:48:13.225504 systemd[1908]: Reached target default.target. Oct 2 18:48:13.225567 systemd[1908]: Startup finished in 192ms. Oct 2 18:48:13.226456 systemd[1]: Started user@500.service. Oct 2 18:48:13.228466 systemd[1]: Started session-1.scope. Oct 2 18:48:13.384318 systemd[1]: Started sshd@1-172.31.22.29:22-139.178.89.65:50016.service. Oct 2 18:48:13.579328 sshd[1917]: Accepted publickey for core from 139.178.89.65 port 50016 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8 Oct 2 18:48:13.583232 sshd[1917]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 18:48:13.591447 systemd-logind[1712]: New session 2 of user core. Oct 2 18:48:13.592381 systemd[1]: Started session-2.scope. Oct 2 18:48:13.740111 sshd[1917]: pam_unix(sshd:session): session closed for user core Oct 2 18:48:13.745853 systemd-logind[1712]: Session 2 logged out. Waiting for processes to exit. Oct 2 18:48:13.746736 systemd[1]: sshd@1-172.31.22.29:22-139.178.89.65:50016.service: Deactivated successfully. Oct 2 18:48:13.747996 systemd[1]: session-2.scope: Deactivated successfully. Oct 2 18:48:13.749509 systemd-logind[1712]: Removed session 2. Oct 2 18:48:13.770702 systemd[1]: Started sshd@2-172.31.22.29:22-139.178.89.65:50026.service. Oct 2 18:48:13.948647 sshd[1923]: Accepted publickey for core from 139.178.89.65 port 50026 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8 Oct 2 18:48:13.951183 sshd[1923]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 18:48:13.959554 systemd-logind[1712]: New session 3 of user core. Oct 2 18:48:13.960494 systemd[1]: Started session-3.scope. Oct 2 18:48:14.091628 sshd[1923]: pam_unix(sshd:session): session closed for user core Oct 2 18:48:14.098554 systemd[1]: sshd@2-172.31.22.29:22-139.178.89.65:50026.service: Deactivated successfully. Oct 2 18:48:14.099820 systemd[1]: session-3.scope: Deactivated successfully. Oct 2 18:48:14.100992 systemd-logind[1712]: Session 3 logged out. Waiting for processes to exit. Oct 2 18:48:14.103406 systemd-logind[1712]: Removed session 3. Oct 2 18:48:14.125339 systemd[1]: Started sshd@3-172.31.22.29:22-139.178.89.65:50032.service. Oct 2 18:48:14.304624 sshd[1929]: Accepted publickey for core from 139.178.89.65 port 50032 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8 Oct 2 18:48:14.307190 sshd[1929]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 18:48:14.315260 systemd-logind[1712]: New session 4 of user core. Oct 2 18:48:14.316166 systemd[1]: Started session-4.scope. Oct 2 18:48:14.464034 sshd[1929]: pam_unix(sshd:session): session closed for user core Oct 2 18:48:14.469598 systemd-logind[1712]: Session 4 logged out. Waiting for processes to exit. Oct 2 18:48:14.470201 systemd[1]: sshd@3-172.31.22.29:22-139.178.89.65:50032.service: Deactivated successfully. Oct 2 18:48:14.471456 systemd[1]: session-4.scope: Deactivated successfully. Oct 2 18:48:14.472932 systemd-logind[1712]: Removed session 4. Oct 2 18:48:14.492906 systemd[1]: Started sshd@4-172.31.22.29:22-139.178.89.65:50040.service. Oct 2 18:48:14.669469 sshd[1935]: Accepted publickey for core from 139.178.89.65 port 50040 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8 Oct 2 18:48:14.672062 sshd[1935]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 18:48:14.680106 systemd-logind[1712]: New session 5 of user core. Oct 2 18:48:14.680991 systemd[1]: Started session-5.scope. Oct 2 18:48:14.858006 sudo[1938]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 2 18:48:14.858977 sudo[1938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 18:48:14.883847 dbus-daemon[1704]: avc: received setenforce notice (enforcing=1) Oct 2 18:48:14.886555 sudo[1938]: pam_unix(sudo:session): session closed for user root Oct 2 18:48:14.910990 sshd[1935]: pam_unix(sshd:session): session closed for user core Oct 2 18:48:14.917168 systemd-logind[1712]: Session 5 logged out. Waiting for processes to exit. Oct 2 18:48:14.917826 systemd[1]: sshd@4-172.31.22.29:22-139.178.89.65:50040.service: Deactivated successfully. Oct 2 18:48:14.919068 systemd[1]: session-5.scope: Deactivated successfully. Oct 2 18:48:14.921139 systemd-logind[1712]: Removed session 5. Oct 2 18:48:14.945381 systemd[1]: Started sshd@5-172.31.22.29:22-139.178.89.65:50056.service. Oct 2 18:48:15.129254 sshd[1942]: Accepted publickey for core from 139.178.89.65 port 50056 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8 Oct 2 18:48:15.132563 sshd[1942]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 18:48:15.140738 systemd-logind[1712]: New session 6 of user core. Oct 2 18:48:15.141615 systemd[1]: Started session-6.scope. Oct 2 18:48:15.263777 sudo[1946]: 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:15.264679 sudo[1946]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 18:48:15.272536 sudo[1946]: pam_unix(sudo:session): session closed for user root Oct 2 18:48:15.286250 sudo[1945]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Oct 2 18:48:15.286873 sudo[1945]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 18:48:15.309770 systemd[1]: Stopping audit-rules.service... Oct 2 18:48:15.314000 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:15.317606 kernel: kauditd_printk_skb: 70 callbacks suppressed Oct 2 18:48:15.317665 kernel: audit: type=1305 audit(1696272495.314:160): 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:15.314000 audit[1949]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff4b1fdd0 a2=420 a3=0 items=0 ppid=1 pid=1949 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:15.323100 auditctl[1949]: No rules Oct 2 18:48:15.335186 systemd[1]: audit-rules.service: Deactivated successfully. Oct 2 18:48:15.338840 kernel: audit: type=1300 audit(1696272495.314:160): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff4b1fdd0 a2=420 a3=0 items=0 ppid=1 pid=1949 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:15.338937 kernel: audit: type=1327 audit(1696272495.314:160): proctitle=2F7362696E2F617564697463746C002D44 Oct 2 18:48:15.314000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Oct 2 18:48:15.335552 systemd[1]: Stopped audit-rules.service. Oct 2 18:48:15.333000 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:15.345986 systemd[1]: Starting audit-rules.service... Oct 2 18:48:15.348634 kernel: audit: type=1131 audit(1696272495.333:161): 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:15.403363 augenrules[1966]: No rules Oct 2 18:48:15.405231 systemd[1]: Finished audit-rules.service. Oct 2 18:48:15.404000 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:15.415639 sudo[1945]: pam_unix(sudo:session): session closed for user root Oct 2 18:48:15.414000 audit[1945]: USER_END pid=1945 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:15.425261 kernel: audit: type=1130 audit(1696272495.404:162): 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:15.425351 kernel: audit: type=1106 audit(1696272495.414:163): pid=1945 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:15.414000 audit[1945]: CRED_DISP pid=1945 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:15.433626 kernel: audit: type=1104 audit(1696272495.414:164): pid=1945 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:15.440236 sshd[1942]: pam_unix(sshd:session): session closed for user core Oct 2 18:48:15.440000 audit[1942]: USER_END pid=1942 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:15.440000 audit[1942]: CRED_DISP pid=1942 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:15.455670 systemd[1]: sshd@5-172.31.22.29:22-139.178.89.65:50056.service: Deactivated successfully. Oct 2 18:48:15.456860 systemd[1]: session-6.scope: Deactivated successfully. Oct 2 18:48:15.458786 systemd-logind[1712]: Session 6 logged out. Waiting for processes to exit. Oct 2 18:48:15.460728 systemd-logind[1712]: Removed session 6. Oct 2 18:48:15.464865 kernel: audit: type=1106 audit(1696272495.440:165): pid=1942 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:15.464932 kernel: audit: type=1104 audit(1696272495.440:166): pid=1942 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:15.465005 kernel: audit: type=1131 audit(1696272495.454:167): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-172.31.22.29:22-139.178.89.65:50056 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:15.454000 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.22.29:22-139.178.89.65:50056 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.088553 systemd[1]: Started sshd@6-172.31.22.29:22-139.178.89.65:38992.service. Oct 2 18:48:22.087000 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.22.29:22-139.178.89.65:38992 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.099629 kernel: audit: type=1130 audit(1696272502.087:168): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-172.31.22.29:22-139.178.89.65:38992 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.261000 audit[1972]: USER_ACCT pid=1972 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:22.263818 sshd[1972]: Accepted publickey for core from 139.178.89.65 port 38992 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8 Oct 2 18:48:22.275631 kernel: audit: type=1101 audit(1696272502.261:169): pid=1972 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:22.274000 audit[1972]: CRED_ACQ pid=1972 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:22.276915 sshd[1972]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 18:48:22.291672 kernel: audit: type=1103 audit(1696272502.274:170): pid=1972 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:22.291807 kernel: audit: type=1006 audit(1696272502.274:171): pid=1972 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=7 res=1 Oct 2 18:48:22.274000 audit[1972]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=fffffa719a00 a2=3 a3=1 items=0 ppid=1 pid=1972 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:22.302335 kernel: audit: type=1300 audit(1696272502.274:171): arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=fffffa719a00 a2=3 a3=1 items=0 ppid=1 pid=1972 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:22.274000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Oct 2 18:48:22.306410 kernel: audit: type=1327 audit(1696272502.274:171): proctitle=737368643A20636F7265205B707269765D Oct 2 18:48:22.311679 systemd-logind[1712]: New session 7 of user core. Oct 2 18:48:22.312754 systemd[1]: Started session-7.scope. Oct 2 18:48:22.320000 audit[1972]: USER_START pid=1972 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:22.334638 kernel: audit: type=1105 audit(1696272502.320:172): pid=1972 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:22.333000 audit[1974]: CRED_ACQ pid=1974 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:22.344613 kernel: audit: type=1103 audit(1696272502.333:173): pid=1974 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:22.447000 audit[1979]: USER_ACCT pid=1979 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.457549 sudo[1979]: core : PWD=/tmp/tmp.B9ZJ3ijajA ; USER=root ; COMMAND=/usr/bin/ldd /usr/bin/ncat Oct 2 18:48:22.458085 sudo[1979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 18:48:22.456000 audit[1979]: CRED_REFR pid=1979 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.466787 kernel: audit: type=1101 audit(1696272502.447:174): pid=1979 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.466846 kernel: audit: type=1110 audit(1696272502.456:175): pid=1979 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.468000 audit[1979]: USER_START pid=1979 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.488069 sudo[1979]: pam_unix(sudo:session): session closed for user root Oct 2 18:48:22.486000 audit[1979]: USER_END pid=1979 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.486000 audit[1979]: CRED_DISP pid=1979 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.501000 audit[1987]: USER_ACCT pid=1987 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.503776 sudo[1987]: core : PWD=/tmp/tmp.B9ZJ3ijajA ; USER=root ; COMMAND=/usr/bin/rsync -av --relative --copy-links /usr/bin/ncat /lib/ld-linux-aarch64.so.1 /lib64/ld-linux-aarch64.so.1 /lib64/libc.so.6 /lib64/libcrypto.so.3 /lib64/libm.so.6 /lib64/libpcap.so.1 /lib64/libssl.so.3 ./ Oct 2 18:48:22.502000 audit[1987]: CRED_REFR pid=1987 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.504296 sudo[1987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 18:48:22.506000 audit[1987]: USER_START pid=1987 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.617717 sudo[1987]: pam_unix(sudo:session): session closed for user root Oct 2 18:48:22.616000 audit[1987]: USER_END pid=1987 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.616000 audit[1987]: CRED_DISP pid=1987 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.629000 audit[1975]: USER_ACCT pid=1975 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.631374 sudo[1975]: core : PWD=/tmp/tmp.B9ZJ3ijajA ; USER=root ; COMMAND=/usr/bin/docker build -t ncat . Oct 2 18:48:22.630000 audit[1975]: CRED_REFR pid=1975 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.632402 sudo[1975]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 18:48:22.634000 audit[1975]: USER_START pid=1975 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:22.703396 systemd[1]: Starting docker.service... Oct 2 18:48:22.807780 env[1997]: time="2023-10-02T18:48:22.807717023Z" level=info msg="Starting up" Oct 2 18:48:22.811657 env[1997]: time="2023-10-02T18:48:22.811552907Z" level=info msg="parsed scheme: \"unix\"" module=grpc Oct 2 18:48:22.811657 env[1997]: time="2023-10-02T18:48:22.811615439Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Oct 2 18:48:22.811830 env[1997]: time="2023-10-02T18:48:22.811693727Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Oct 2 18:48:22.811830 env[1997]: time="2023-10-02T18:48:22.811720703Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Oct 2 18:48:22.817361 env[1997]: time="2023-10-02T18:48:22.817317815Z" level=info msg="parsed scheme: \"unix\"" module=grpc Oct 2 18:48:22.817556 env[1997]: time="2023-10-02T18:48:22.817527827Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Oct 2 18:48:22.817713 env[1997]: time="2023-10-02T18:48:22.817681979Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Oct 2 18:48:22.817823 env[1997]: time="2023-10-02T18:48:22.817795847Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Oct 2 18:48:22.830832 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport2916656048-merged.mount: Deactivated successfully. Oct 2 18:48:22.868410 env[1997]: time="2023-10-02T18:48:22.867710399Z" level=info msg="Loading containers: start." Oct 2 18:48:22.981000 audit[2028]: NETFILTER_CFG table=nat:2 family=2 entries=2 op=nft_register_chain pid=2028 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:22.981000 audit[2028]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=116 a0=3 a1=ffffdac72b40 a2=0 a3=1 items=0 ppid=1997 pid=2028 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:22.981000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4E00444F434B4552 Oct 2 18:48:22.987000 audit[2030]: NETFILTER_CFG table=filter:3 family=2 entries=2 op=nft_register_chain pid=2030 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:22.987000 audit[2030]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=124 a0=3 a1=ffffc2feeeb0 a2=0 a3=1 items=0 ppid=1997 pid=2030 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:22.987000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D740066696C746572002D4E00444F434B4552 Oct 2 18:48:22.994000 audit[2032]: NETFILTER_CFG table=filter:4 family=2 entries=1 op=nft_register_chain pid=2032 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:22.994000 audit[2032]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=112 a0=3 a1=ffffebe127b0 a2=0 a3=1 items=0 ppid=1997 pid=2032 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:22.994000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D740066696C746572002D4E00444F434B45522D49534F4C4154494F4E2D53544147452D31 Oct 2 18:48:23.001000 audit[2034]: NETFILTER_CFG table=filter:5 family=2 entries=1 op=nft_register_chain pid=2034 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.001000 audit[2034]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=112 a0=3 a1=fffff626f950 a2=0 a3=1 items=0 ppid=1997 pid=2034 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.001000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D740066696C746572002D4E00444F434B45522D49534F4C4154494F4E2D53544147452D32 Oct 2 18:48:23.009000 audit[2036]: NETFILTER_CFG table=filter:6 family=2 entries=1 op=nft_register_rule pid=2036 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.009000 audit[2036]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=228 a0=3 a1=ffffc5d22e00 a2=0 a3=1 items=0 ppid=1997 pid=2036 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.009000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4100444F434B45522D49534F4C4154494F4E2D53544147452D31002D6A0052455455524E Oct 2 18:48:23.045000 audit[2041]: NETFILTER_CFG table=filter:7 family=2 entries=1 op=nft_register_rule pid=2041 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.045000 audit[2041]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=228 a0=3 a1=ffffd1658080 a2=0 a3=1 items=0 ppid=1997 pid=2041 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.045000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4100444F434B45522D49534F4C4154494F4E2D53544147452D32002D6A0052455455524E Oct 2 18:48:23.061000 audit[2043]: NETFILTER_CFG table=filter:8 family=2 entries=1 op=nft_register_chain pid=2043 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.061000 audit[2043]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=96 a0=3 a1=ffffe39fbaf0 a2=0 a3=1 items=0 ppid=1997 pid=2043 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.061000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D740066696C746572002D4E00444F434B45522D55534552 Oct 2 18:48:23.069000 audit[2045]: NETFILTER_CFG table=filter:9 family=2 entries=1 op=nft_register_rule pid=2045 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.069000 audit[2045]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=212 a0=3 a1=ffffd023ffd0 a2=0 a3=1 items=0 ppid=1997 pid=2045 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.069000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4100444F434B45522D55534552002D6A0052455455524E Oct 2 18:48:23.076000 audit[2047]: NETFILTER_CFG table=filter:10 family=2 entries=2 op=nft_register_chain pid=2047 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.076000 audit[2047]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=308 a0=3 a1=ffffe87fc5a0 a2=0 a3=1 items=0 ppid=1997 pid=2047 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.076000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4900464F5257415244002D6A00444F434B45522D55534552 Oct 2 18:48:23.096000 audit[2051]: NETFILTER_CFG table=filter:11 family=2 entries=1 op=nft_unregister_rule pid=2051 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.096000 audit[2051]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=216 a0=3 a1=ffffcd472fb0 a2=0 a3=1 items=0 ppid=1997 pid=2051 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.096000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4400464F5257415244002D6A00444F434B45522D55534552 Oct 2 18:48:23.099000 audit[2052]: NETFILTER_CFG table=filter:12 family=2 entries=1 op=nft_register_rule pid=2052 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.099000 audit[2052]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=224 a0=3 a1=ffffec70af00 a2=0 a3=1 items=0 ppid=1997 pid=2052 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.099000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4900464F5257415244002D6A00444F434B45522D55534552 Oct 2 18:48:23.114641 kernel: Initializing XFRM netlink socket Oct 2 18:48:23.159677 env[1997]: time="2023-10-02T18:48:23.159608793Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Oct 2 18:48:23.162350 (udev-worker)[2008]: Network interface NamePolicy= disabled on kernel command line. Oct 2 18:48:23.203000 audit[2060]: NETFILTER_CFG table=nat:13 family=2 entries=2 op=nft_register_chain pid=2060 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.203000 audit[2060]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=492 a0=3 a1=ffffdeb4cc30 a2=0 a3=1 items=0 ppid=1997 pid=2060 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.203000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4900504F5354524F5554494E47002D73003137322E31372E302E302F31360000002D6F00646F636B657230002D6A004D415351554552414445 Oct 2 18:48:23.221000 audit[2063]: NETFILTER_CFG table=nat:14 family=2 entries=1 op=nft_register_rule pid=2063 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.221000 audit[2063]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=288 a0=3 a1=ffffd2939c60 a2=0 a3=1 items=0 ppid=1997 pid=2063 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.221000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4900444F434B4552002D6900646F636B657230002D6A0052455455524E Oct 2 18:48:23.234000 audit[2066]: NETFILTER_CFG table=filter:15 family=2 entries=1 op=nft_register_rule pid=2066 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.234000 audit[2066]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=376 a0=3 a1=ffffcc9f2bd0 a2=0 a3=1 items=0 ppid=1997 pid=2066 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.234000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4900464F5257415244002D6900646F636B657230002D6F00646F636B657230002D6A00414343455054 Oct 2 18:48:23.241000 audit[2068]: NETFILTER_CFG table=filter:16 family=2 entries=1 op=nft_register_rule pid=2068 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.241000 audit[2068]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=376 a0=3 a1=fffffaf5ebd0 a2=0 a3=1 items=0 ppid=1997 pid=2068 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.241000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4900464F5257415244002D6900646F636B6572300000002D6F00646F636B657230002D6A00414343455054 Oct 2 18:48:23.248000 audit[2070]: NETFILTER_CFG table=nat:17 family=2 entries=2 op=nft_register_chain pid=2070 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.248000 audit[2070]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=356 a0=3 a1=fffff55f8e10 a2=0 a3=1 items=0 ppid=1997 pid=2070 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.248000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4100505245524F5554494E47002D6D006164647274797065002D2D6473742D74797065004C4F43414C002D6A00444F434B4552 Oct 2 18:48:23.257000 audit[2072]: NETFILTER_CFG table=nat:18 family=2 entries=2 op=nft_register_chain pid=2072 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.257000 audit[2072]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=444 a0=3 a1=ffffeb2aa520 a2=0 a3=1 items=0 ppid=1997 pid=2072 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.257000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D41004F5554505554002D6D006164647274797065002D2D6473742D74797065004C4F43414C002D6A00444F434B45520000002D2D647374003132372E302E302E302F38 Oct 2 18:48:23.265000 audit[2074]: NETFILTER_CFG table=filter:19 family=2 entries=1 op=nft_register_rule pid=2074 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.265000 audit[2074]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=304 a0=3 a1=fffff1078340 a2=0 a3=1 items=0 ppid=1997 pid=2074 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.265000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4900464F5257415244002D6F00646F636B657230002D6A00444F434B4552 Oct 2 18:48:23.283000 audit[2077]: NETFILTER_CFG table=filter:20 family=2 entries=1 op=nft_register_rule pid=2077 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.283000 audit[2077]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=508 a0=3 a1=ffffe5055360 a2=0 a3=1 items=0 ppid=1997 pid=2077 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.283000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4900464F5257415244002D6F00646F636B657230002D6D00636F6E6E747261636B002D2D637473746174650052454C415445442C45535441424C4953484544002D6A00414343455054 Oct 2 18:48:23.290000 audit[2079]: NETFILTER_CFG table=filter:21 family=2 entries=1 op=nft_register_rule pid=2079 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.290000 audit[2079]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=240 a0=3 a1=ffffcd8ba4e0 a2=0 a3=1 items=0 ppid=1997 pid=2079 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.290000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4900464F5257415244002D6A00444F434B45522D49534F4C4154494F4E2D53544147452D31 Oct 2 18:48:23.297000 audit[2081]: NETFILTER_CFG table=filter:22 family=2 entries=1 op=nft_register_rule pid=2081 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.297000 audit[2081]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=428 a0=3 a1=ffffc5e781e0 a2=0 a3=1 items=0 ppid=1997 pid=2081 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.297000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D740066696C746572002D4900444F434B45522D49534F4C4154494F4E2D53544147452D31002D6900646F636B6572300000002D6F00646F636B657230002D6A00444F434B45522D49534F4C4154494F4E2D53544147452D32 Oct 2 18:48:23.305000 audit[2083]: NETFILTER_CFG table=filter:23 family=2 entries=1 op=nft_register_rule pid=2083 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.305000 audit[2083]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=312 a0=3 a1=fffffc56c0b0 a2=0 a3=1 items=0 ppid=1997 pid=2083 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.305000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D740066696C746572002D4900444F434B45522D49534F4C4154494F4E2D53544147452D32002D6F00646F636B657230002D6A0044524F50 Oct 2 18:48:23.307733 systemd-networkd[1542]: docker0: Link UP Oct 2 18:48:23.338000 audit[2087]: NETFILTER_CFG table=filter:24 family=2 entries=1 op=nft_unregister_rule pid=2087 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.338000 audit[2087]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=228 a0=3 a1=ffffc69180f0 a2=0 a3=1 items=0 ppid=1997 pid=2087 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.338000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4400464F5257415244002D6A00444F434B45522D55534552 Oct 2 18:48:23.344000 audit[2088]: NETFILTER_CFG table=filter:25 family=2 entries=1 op=nft_register_rule pid=2088 subj=system_u:system_r:kernel_t:s0 comm="iptables" Oct 2 18:48:23.344000 audit[2088]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=224 a0=3 a1=ffffe59cfe70 a2=0 a3=1 items=0 ppid=1997 pid=2088 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:23.344000 audit: PROCTITLE proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D4900464F5257415244002D6A00444F434B45522D55534552 Oct 2 18:48:23.346779 env[1997]: time="2023-10-02T18:48:23.346731850Z" level=info msg="Loading containers: done." Oct 2 18:48:23.374431 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck786747539-merged.mount: Deactivated successfully. Oct 2 18:48:23.390882 env[1997]: time="2023-10-02T18:48:23.390801574Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Oct 2 18:48:23.391233 env[1997]: time="2023-10-02T18:48:23.391185742Z" level=info msg="Docker daemon" commit=112bdf3343 graphdriver(s)=overlay2 version=20.10.23 Oct 2 18:48:23.391411 env[1997]: time="2023-10-02T18:48:23.391368874Z" level=info msg="Daemon has completed initialization" Oct 2 18:48:23.426561 systemd[1]: Started docker.service. Oct 2 18:48:23.425000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=docker comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:23.436808 env[1997]: time="2023-10-02T18:48:23.436614682Z" level=info msg="API listen on /run/docker.sock" Oct 2 18:48:23.929298 sudo[1975]: pam_unix(sudo:session): session closed for user root Oct 2 18:48:23.927000 audit[1975]: USER_END pid=1975 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:23.928000 audit[1975]: CRED_DISP pid=1975 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 2 18:48:23.952926 sshd[1972]: pam_unix(sshd:session): session closed for user core Oct 2 18:48:23.953000 audit[1972]: USER_END pid=1972 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:23.953000 audit[1972]: CRED_DISP pid=1972 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:23.958577 systemd-logind[1712]: Session 7 logged out. Waiting for processes to exit. Oct 2 18:48:23.959002 systemd[1]: sshd@6-172.31.22.29:22-139.178.89.65:38992.service: Deactivated successfully. Oct 2 18:48:23.960198 systemd[1]: session-7.scope: Deactivated successfully. Oct 2 18:48:23.957000 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.22.29:22-139.178.89.65:38992 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:23.961822 systemd-logind[1712]: Removed session 7. Oct 2 18:48:26.959000 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.22.29:22-139.178.89.65:37852 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:26.960733 systemd[1]: Started sshd@7-172.31.22.29:22-139.178.89.65:37852.service. Oct 2 18:48:27.135000 audit[2128]: USER_ACCT pid=2128 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:27.138636 kernel: kauditd_printk_skb: 90 callbacks suppressed Oct 2 18:48:27.138722 kernel: audit: type=1101 audit(1696272507.135:218): pid=2128 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:27.138885 sshd[2128]: Accepted publickey for core from 139.178.89.65 port 37852 ssh2: RSA SHA256:ePkK8jKoGlhN3AxcTQ2G+RQZHD5kDZhw675IJmRySH8 Oct 2 18:48:27.142716 sshd[2128]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 18:48:27.137000 audit[2128]: CRED_ACQ pid=2128 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:27.158286 kernel: audit: type=1103 audit(1696272507.137:219): pid=2128 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:27.163455 systemd[1]: Started session-8.scope. Oct 2 18:48:27.164621 kernel: audit: type=1006 audit(1696272507.137:220): pid=2128 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=8 res=1 Oct 2 18:48:27.164697 kernel: audit: type=1300 audit(1696272507.137:220): arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=fffffed04410 a2=3 a3=1 items=0 ppid=1 pid=2128 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:27.137000 audit[2128]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=fffffed04410 a2=3 a3=1 items=0 ppid=1 pid=2128 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:27.166605 systemd-logind[1712]: New session 8 of user core. Oct 2 18:48:27.181878 kernel: audit: type=1327 audit(1696272507.137:220): proctitle=737368643A20636F7265205B707269765D Oct 2 18:48:27.182077 kernel: audit: type=1105 audit(1696272507.173:221): pid=2128 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:27.137000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Oct 2 18:48:27.173000 audit[2128]: USER_START pid=2128 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:27.182000 audit[2130]: CRED_ACQ pid=2130 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:27.197965 kernel: audit: type=1103 audit(1696272507.182:222): pid=2130 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:27.347392 systemd[1]: var-lib-docker-overlay2-1aaeb8c14853c23478b13c9bd49d072a2dd9008345e33703b4cd46f05aaaff05\x2dinit-merged.mount: Deactivated successfully. Oct 2 18:48:27.399618 systemd[1]: var-lib-docker-overlay2-1aaeb8c14853c23478b13c9bd49d072a2dd9008345e33703b4cd46f05aaaff05-merged.mount: Deactivated successfully. Oct 2 18:48:27.433796 kernel: docker0: port 1(veth886904d) entered blocking state Oct 2 18:48:27.433940 kernel: docker0: port 1(veth886904d) entered disabled state Oct 2 18:48:27.438779 kernel: device veth886904d entered promiscuous mode Oct 2 18:48:27.455632 kernel: audit: type=1700 audit(1696272507.425:223): dev=veth886904d prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295 Oct 2 18:48:27.455720 kernel: audit: type=1300 audit(1696272507.425:223): arch=c00000b7 syscall=206 success=yes exit=40 a0=f a1=4000d21920 a2=28 a3=0 items=0 ppid=1 pid=1997 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/run/torcx/unpack/docker/bin/dockerd" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:27.425000 audit: ANOM_PROMISCUOUS dev=veth886904d prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295 Oct 2 18:48:27.425000 audit[1997]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=40 a0=f a1=4000d21920 a2=28 a3=0 items=0 ppid=1 pid=1997 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/run/torcx/unpack/docker/bin/dockerd" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:27.440556 (udev-worker)[2143]: Network interface NamePolicy= disabled on kernel command line. Oct 2 18:48:27.441670 systemd-networkd[1542]: veth886904d: Link UP Oct 2 18:48:27.425000 audit: PROCTITLE proctitle=2F72756E2F746F7263782F62696E2F646F636B657264002D2D686F73743D66643A2F2F002D2D636F6E7461696E6572643D2F7661722F72756E2F646F636B65722F6C6962636F6E7461696E6572642F646F636B65722D636F6E7461696E6572642E736F636B002D2D73656C696E75782D656E61626C65643D74727565 Oct 2 18:48:27.467162 kernel: audit: type=1327 audit(1696272507.425:223): proctitle=2F72756E2F746F7263782F62696E2F646F636B657264002D2D686F73743D66643A2F2F002D2D636F6E7461696E6572643D2F7661722F72756E2F646F636B65722F6C6962636F6E7461696E6572642F646F636B65722D636F6E7461696E6572642E736F636B002D2D73656C696E75782D656E61626C65643D74727565 Oct 2 18:48:27.457300 (udev-worker)[2142]: Network interface NamePolicy= disabled on kernel command line. Oct 2 18:48:27.533926 env[1726]: time="2023-10-02T18:48:27.533811194Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 2 18:48:27.534675 env[1726]: time="2023-10-02T18:48:27.533889206Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 2 18:48:27.534675 env[1726]: time="2023-10-02T18:48:27.533916302Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 2 18:48:27.534675 env[1726]: time="2023-10-02T18:48:27.534239018Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/ddd646a1389908a3f147c31be6cccd8508c9e08e235ae6826ffc3765ebd4d938 pid=2159 runtime=io.containerd.runc.v2 Oct 2 18:48:27.566878 systemd[1]: Started docker-ddd646a1389908a3f147c31be6cccd8508c9e08e235ae6826ffc3765ebd4d938.scope. Oct 2 18:48:27.608000 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=0 Oct 2 18:48:27.608000 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=0 Oct 2 18:48:27.608000 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=0 Oct 2 18:48:27.608000 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=0 Oct 2 18:48:27.608000 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=0 Oct 2 18:48:27.608000 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=0 Oct 2 18:48:27.608000 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=0 Oct 2 18:48:27.608000 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=0 Oct 2 18:48:27.608000 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=0 Oct 2 18:48:27.608000 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=0 Oct 2 18:48:27.608000 audit: BPF prog-id=34 op=LOAD Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=0 a0=f a1=40001bdb38 a2=10 a3=0 items=0 ppid=2159 pid=2169 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:27.611000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F64646436343661313338393930386133663134376333316265 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=15 a0=0 a1=40001bd5a0 a2=3c a3=0 items=0 ppid=2159 pid=2169 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:27.611000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F64646436343661313338393930386133663134376333316265 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit: BPF prog-id=35 op=LOAD Oct 2 18:48:27.611000 audit[2169]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=15 a0=5 a1=40001bd8e0 a2=78 a3=0 items=0 ppid=2159 pid=2169 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:27.611000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F64646436343661313338393930386133663134376333316265 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit: BPF prog-id=36 op=LOAD Oct 2 18:48:27.611000 audit[2169]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=17 a0=5 a1=40001bd670 a2=78 a3=0 items=0 ppid=2159 pid=2169 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:27.611000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F64646436343661313338393930386133663134376333316265 Oct 2 18:48:27.611000 audit: BPF prog-id=36 op=UNLOAD Oct 2 18:48:27.611000 audit: BPF prog-id=35 op=UNLOAD Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { perfmon } for pid=2169 comm="runc" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit[2169]: AVC avc: denied { bpf } for pid=2169 comm="runc" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=0 Oct 2 18:48:27.611000 audit: BPF prog-id=37 op=LOAD Oct 2 18:48:27.611000 audit[2169]: SYSCALL arch=c00000b7 syscall=280 success=yes exit=15 a0=5 a1=40001bdb40 a2=78 a3=0 items=0 ppid=2159 pid=2169 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/run/torcx/unpack/docker/bin/runc" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:27.611000 audit: PROCTITLE proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F64646436343661313338393930386133663134376333316265 Oct 2 18:48:27.815628 kernel: eth0: renamed from vethf1b3e06 Oct 2 18:48:27.824725 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth886904d: link becomes ready Oct 2 18:48:27.824830 kernel: docker0: port 1(veth886904d) entered blocking state Oct 2 18:48:27.829035 kernel: docker0: port 1(veth886904d) entered forwarding state Oct 2 18:48:27.829112 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): docker0: link becomes ready Oct 2 18:48:27.829291 systemd-networkd[1542]: veth886904d: Gained carrier Oct 2 18:48:27.831842 systemd-networkd[1542]: docker0: Gained carrier Oct 2 18:48:27.899000 audit: BPF prog-id=34 op=UNLOAD Oct 2 18:48:27.900609 systemd[1]: docker-ddd646a1389908a3f147c31be6cccd8508c9e08e235ae6826ffc3765ebd4d938.scope: Deactivated successfully. Oct 2 18:48:27.931629 env[1997]: time="2023-10-02T18:48:27.931541656Z" level=info msg="ignoring event" container=ddd646a1389908a3f147c31be6cccd8508c9e08e235ae6826ffc3765ebd4d938 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Oct 2 18:48:27.932341 env[1726]: time="2023-10-02T18:48:27.932261512Z" level=info msg="shim disconnected" id=ddd646a1389908a3f147c31be6cccd8508c9e08e235ae6826ffc3765ebd4d938 Oct 2 18:48:27.932478 env[1726]: time="2023-10-02T18:48:27.932343496Z" level=warning msg="cleaning up after shim disconnected" id=ddd646a1389908a3f147c31be6cccd8508c9e08e235ae6826ffc3765ebd4d938 namespace=moby Oct 2 18:48:27.932478 env[1726]: time="2023-10-02T18:48:27.932371672Z" level=info msg="cleaning up dead shim" Oct 2 18:48:27.959145 env[1726]: time="2023-10-02T18:48:27.959076077Z" level=warning msg="cleanup warnings time=\"2023-10-02T18:48:27Z\" level=info msg=\"starting signal loop\" namespace=moby pid=2213 runtime=io.containerd.runc.v2\n" Oct 2 18:48:27.968181 systemd-networkd[1542]: veth886904d: Lost carrier Oct 2 18:48:27.970002 kernel: docker0: port 1(veth886904d) entered disabled state Oct 2 18:48:27.970092 kernel: vethf1b3e06: renamed from eth0 Oct 2 18:48:27.987378 systemd-networkd[1542]: veth886904d: Link DOWN Oct 2 18:48:27.991626 kernel: docker0: port 1(veth886904d) entered disabled state Oct 2 18:48:27.985000 audit: ANOM_PROMISCUOUS dev=veth886904d prom=0 old_prom=256 auid=4294967295 uid=0 gid=0 ses=4294967295 Oct 2 18:48:27.997124 kernel: device veth886904d left promiscuous mode Oct 2 18:48:27.997243 kernel: docker0: port 1(veth886904d) entered disabled state Oct 2 18:48:27.985000 audit[1997]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=32 a0=f a1=4000059560 a2=20 a3=0 items=0 ppid=1 pid=1997 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/run/torcx/unpack/docker/bin/dockerd" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 18:48:27.985000 audit: PROCTITLE proctitle=2F72756E2F746F7263782F62696E2F646F636B657264002D2D686F73743D66643A2F2F002D2D636F6E7461696E6572643D2F7661722F72756E2F646F636B65722F6C6962636F6E7461696E6572642F646F636B65722D636F6E7461696E6572642E736F636B002D2D73656C696E75782D656E61626C65643D74727565 Oct 2 18:48:28.044000 audit: BPF prog-id=37 op=UNLOAD Oct 2 18:48:28.074971 sshd[2128]: pam_unix(sshd:session): session closed for user core Oct 2 18:48:28.075000 audit[2128]: USER_END pid=2128 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:28.075000 audit[2128]: CRED_DISP pid=2128 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:28.080900 systemd[1]: session-8.scope: Deactivated successfully. Oct 2 18:48:28.081990 systemd[1]: sshd@7-172.31.22.29:22-139.178.89.65:37852.service: Deactivated successfully. Oct 2 18:48:28.080000 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.22.29:22-139.178.89.65:37852 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 18:48:28.083757 systemd-logind[1712]: Session 8 logged out. Waiting for processes to exit. Oct 2 18:48:28.085551 systemd-logind[1712]: Removed session 8. Oct 2 18:48:28.339896 systemd[1]: var-lib-docker-overlay2-1aaeb8c14853c23478b13c9bd49d072a2dd9008345e33703b4cd46f05aaaff05-merged.mount: Deactivated successfully. Oct 2 18:48:28.428889 systemd-networkd[1542]: docker0: Lost carrier Oct 2 18:48:29.708783 systemd-networkd[1542]: docker0: Gained IPv6LL