Oct 2 19:18:09.087246 kernel: Linux version 5.15.132-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-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 Mon Oct 2 17:52:37 -00 2023 Oct 2 19:18:09.087280 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=ttyS0,115200n8 flatcar.first_boot=detected flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=96b0fdb9f11bf1422adc9955c78c8182df387766badfd0b94e08fb9688739ee1 Oct 2 19:18:09.087295 kernel: BIOS-provided physical RAM map: Oct 2 19:18:09.087306 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Oct 2 19:18:09.087500 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Oct 2 19:18:09.087514 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Oct 2 19:18:09.087532 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007d9e9fff] usable Oct 2 19:18:09.087544 kernel: BIOS-e820: [mem 0x000000007d9ea000-0x000000007fffffff] reserved Oct 2 19:18:09.087556 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000e03fffff] reserved Oct 2 19:18:09.087567 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Oct 2 19:18:09.087579 kernel: NX (Execute Disable) protection: active Oct 2 19:18:09.087590 kernel: SMBIOS 2.7 present. Oct 2 19:18:09.087602 kernel: DMI: Amazon EC2 t3.small/, BIOS 1.0 10/16/2017 Oct 2 19:18:09.087614 kernel: Hypervisor detected: KVM Oct 2 19:18:09.087632 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Oct 2 19:18:09.087645 kernel: kvm-clock: cpu 0, msr 55f8a001, primary cpu clock Oct 2 19:18:09.087658 kernel: kvm-clock: using sched offset of 5903677250 cycles Oct 2 19:18:09.087672 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 2 19:18:09.087686 kernel: tsc: Detected 2500.004 MHz processor Oct 2 19:18:09.087699 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 2 19:18:09.087715 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 2 19:18:09.087728 kernel: last_pfn = 0x7d9ea max_arch_pfn = 0x400000000 Oct 2 19:18:09.087741 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 2 19:18:09.087754 kernel: Using GB pages for direct mapping Oct 2 19:18:09.087768 kernel: ACPI: Early table checksum verification disabled Oct 2 19:18:09.087781 kernel: ACPI: RSDP 0x00000000000F8F40 000014 (v00 AMAZON) Oct 2 19:18:09.087794 kernel: ACPI: RSDT 0x000000007D9EE350 000044 (v01 AMAZON AMZNRSDT 00000001 AMZN 00000001) Oct 2 19:18:09.087807 kernel: ACPI: FACP 0x000000007D9EFF80 000074 (v01 AMAZON AMZNFACP 00000001 AMZN 00000001) Oct 2 19:18:09.087820 kernel: ACPI: DSDT 0x000000007D9EE3A0 0010E9 (v01 AMAZON AMZNDSDT 00000001 AMZN 00000001) Oct 2 19:18:09.087836 kernel: ACPI: FACS 0x000000007D9EFF40 000040 Oct 2 19:18:09.087849 kernel: ACPI: SSDT 0x000000007D9EF6C0 00087A (v01 AMAZON AMZNSSDT 00000001 AMZN 00000001) Oct 2 19:18:09.087862 kernel: ACPI: APIC 0x000000007D9EF5D0 000076 (v01 AMAZON AMZNAPIC 00000001 AMZN 00000001) Oct 2 19:18:09.087875 kernel: ACPI: SRAT 0x000000007D9EF530 0000A0 (v01 AMAZON AMZNSRAT 00000001 AMZN 00000001) Oct 2 19:18:09.087887 kernel: ACPI: SLIT 0x000000007D9EF4C0 00006C (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Oct 2 19:18:09.087898 kernel: ACPI: WAET 0x000000007D9EF490 000028 (v01 AMAZON AMZNWAET 00000001 AMZN 00000001) Oct 2 19:18:09.087911 kernel: ACPI: HPET 0x00000000000C9000 000038 (v01 AMAZON AMZNHPET 00000001 AMZN 00000001) Oct 2 19:18:09.087923 kernel: ACPI: SSDT 0x00000000000C9040 00007B (v01 AMAZON AMZNSSDT 00000001 AMZN 00000001) Oct 2 19:18:09.087939 kernel: ACPI: Reserving FACP table memory at [mem 0x7d9eff80-0x7d9efff3] Oct 2 19:18:09.087951 kernel: ACPI: Reserving DSDT table memory at [mem 0x7d9ee3a0-0x7d9ef488] Oct 2 19:18:09.087964 kernel: ACPI: Reserving FACS table memory at [mem 0x7d9eff40-0x7d9eff7f] Oct 2 19:18:09.087983 kernel: ACPI: Reserving SSDT table memory at [mem 0x7d9ef6c0-0x7d9eff39] Oct 2 19:18:09.087998 kernel: ACPI: Reserving APIC table memory at [mem 0x7d9ef5d0-0x7d9ef645] Oct 2 19:18:09.088012 kernel: ACPI: Reserving SRAT table memory at [mem 0x7d9ef530-0x7d9ef5cf] Oct 2 19:18:09.088026 kernel: ACPI: Reserving SLIT table memory at [mem 0x7d9ef4c0-0x7d9ef52b] Oct 2 19:18:09.088043 kernel: ACPI: Reserving WAET table memory at [mem 0x7d9ef490-0x7d9ef4b7] Oct 2 19:18:09.088058 kernel: ACPI: Reserving HPET table memory at [mem 0xc9000-0xc9037] Oct 2 19:18:09.088072 kernel: ACPI: Reserving SSDT table memory at [mem 0xc9040-0xc90ba] Oct 2 19:18:09.088095 kernel: SRAT: PXM 0 -> APIC 0x00 -> Node 0 Oct 2 19:18:09.088108 kernel: SRAT: PXM 0 -> APIC 0x01 -> Node 0 Oct 2 19:18:09.088122 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x7fffffff] Oct 2 19:18:09.088136 kernel: NUMA: Initialized distance table, cnt=1 Oct 2 19:18:09.088149 kernel: NODE_DATA(0) allocated [mem 0x7d9e3000-0x7d9e8fff] Oct 2 19:18:09.088167 kernel: Zone ranges: Oct 2 19:18:09.088181 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 2 19:18:09.088195 kernel: DMA32 [mem 0x0000000001000000-0x000000007d9e9fff] Oct 2 19:18:09.088209 kernel: Normal empty Oct 2 19:18:09.088222 kernel: Movable zone start for each node Oct 2 19:18:09.088236 kernel: Early memory node ranges Oct 2 19:18:09.088250 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Oct 2 19:18:09.088264 kernel: node 0: [mem 0x0000000000100000-0x000000007d9e9fff] Oct 2 19:18:09.088278 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007d9e9fff] Oct 2 19:18:09.088294 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 2 19:18:09.088308 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Oct 2 19:18:09.088322 kernel: On node 0, zone DMA32: 9750 pages in unavailable ranges Oct 2 19:18:09.088336 kernel: ACPI: PM-Timer IO Port: 0xb008 Oct 2 19:18:09.088350 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Oct 2 19:18:09.088364 kernel: IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23 Oct 2 19:18:09.088378 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Oct 2 19:18:09.088392 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 2 19:18:09.088406 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Oct 2 19:18:09.088423 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Oct 2 19:18:09.088437 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 2 19:18:09.088450 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Oct 2 19:18:09.088464 kernel: TSC deadline timer available Oct 2 19:18:09.088478 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs Oct 2 19:18:09.088492 kernel: [mem 0x80000000-0xdfffffff] available for PCI devices Oct 2 19:18:09.088506 kernel: Booting paravirtualized kernel on KVM Oct 2 19:18:09.088520 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 2 19:18:09.088534 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:2 nr_node_ids:1 Oct 2 19:18:09.088551 kernel: percpu: Embedded 55 pages/cpu s185624 r8192 d31464 u1048576 Oct 2 19:18:09.088565 kernel: pcpu-alloc: s185624 r8192 d31464 u1048576 alloc=1*2097152 Oct 2 19:18:09.088578 kernel: pcpu-alloc: [0] 0 1 Oct 2 19:18:09.088592 kernel: kvm-guest: stealtime: cpu 0, msr 7b61c0c0 Oct 2 19:18:09.088606 kernel: kvm-guest: PV spinlocks enabled Oct 2 19:18:09.088620 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 2 19:18:09.088634 kernel: Built 1 zonelists, mobility grouping on. Total pages: 506242 Oct 2 19:18:09.088648 kernel: Policy zone: DMA32 Oct 2 19:18:09.088664 kernel: Kernel command line: rootflags=rw mount.usrflags=ro 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=ttyS0,115200n8 flatcar.first_boot=detected flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=96b0fdb9f11bf1422adc9955c78c8182df387766badfd0b94e08fb9688739ee1 Oct 2 19:18:09.088681 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 2 19:18:09.088695 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 2 19:18:09.088709 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Oct 2 19:18:09.088723 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 2 19:18:09.088737 kernel: Memory: 1936476K/2057760K available (12294K kernel code, 2274K rwdata, 13692K rodata, 45372K init, 4176K bss, 121024K reserved, 0K cma-reserved) Oct 2 19:18:09.088751 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 2 19:18:09.088765 kernel: Kernel/User page tables isolation: enabled Oct 2 19:18:09.088778 kernel: ftrace: allocating 34453 entries in 135 pages Oct 2 19:18:09.088794 kernel: ftrace: allocated 135 pages with 4 groups Oct 2 19:18:09.088809 kernel: rcu: Hierarchical RCU implementation. Oct 2 19:18:09.088824 kernel: rcu: RCU event tracing is enabled. Oct 2 19:18:09.088838 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 2 19:18:09.088853 kernel: Rude variant of Tasks RCU enabled. Oct 2 19:18:09.088867 kernel: Tracing variant of Tasks RCU enabled. Oct 2 19:18:09.088881 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 2 19:18:09.088895 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 2 19:18:09.088909 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16 Oct 2 19:18:09.088926 kernel: random: crng init done Oct 2 19:18:09.088939 kernel: Console: colour VGA+ 80x25 Oct 2 19:18:09.088953 kernel: printk: console [ttyS0] enabled Oct 2 19:18:09.088968 kernel: ACPI: Core revision 20210730 Oct 2 19:18:09.088982 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 30580167144 ns Oct 2 19:18:09.088996 kernel: APIC: Switch to symmetric I/O mode setup Oct 2 19:18:09.089010 kernel: x2apic enabled Oct 2 19:18:09.089023 kernel: Switched APIC routing to physical x2apic. Oct 2 19:18:09.089046 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x24093d6e846, max_idle_ns: 440795249997 ns Oct 2 19:18:09.089064 kernel: Calibrating delay loop (skipped) preset value.. 5000.00 BogoMIPS (lpj=2500004) Oct 2 19:18:09.089078 kernel: Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8 Oct 2 19:18:09.089107 kernel: Last level dTLB entries: 4KB 64, 2MB 0, 4MB 0, 1GB 4 Oct 2 19:18:09.089119 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 2 19:18:09.089142 kernel: Spectre V2 : Mitigation: Retpolines Oct 2 19:18:09.089157 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Oct 2 19:18:09.089170 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Oct 2 19:18:09.089184 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Oct 2 19:18:09.089197 kernel: RETBleed: Vulnerable Oct 2 19:18:09.089209 kernel: Speculative Store Bypass: Vulnerable Oct 2 19:18:09.089221 kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Oct 2 19:18:09.089233 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Oct 2 19:18:09.089244 kernel: GDS: Unknown: Dependent on hypervisor status Oct 2 19:18:09.089257 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 2 19:18:09.089272 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 2 19:18:09.089286 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 2 19:18:09.089300 kernel: x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers' Oct 2 19:18:09.089313 kernel: x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR' Oct 2 19:18:09.089326 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Oct 2 19:18:09.089342 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Oct 2 19:18:09.089355 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Oct 2 19:18:09.089369 kernel: x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' Oct 2 19:18:09.089383 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 2 19:18:09.089396 kernel: x86/fpu: xstate_offset[3]: 832, xstate_sizes[3]: 64 Oct 2 19:18:09.089410 kernel: x86/fpu: xstate_offset[4]: 896, xstate_sizes[4]: 64 Oct 2 19:18:09.089424 kernel: x86/fpu: xstate_offset[5]: 960, xstate_sizes[5]: 64 Oct 2 19:18:09.089492 kernel: x86/fpu: xstate_offset[6]: 1024, xstate_sizes[6]: 512 Oct 2 19:18:09.089508 kernel: x86/fpu: xstate_offset[7]: 1536, xstate_sizes[7]: 1024 Oct 2 19:18:09.089521 kernel: x86/fpu: xstate_offset[9]: 2560, xstate_sizes[9]: 8 Oct 2 19:18:09.089534 kernel: x86/fpu: Enabled xstate features 0x2ff, context size is 2568 bytes, using 'compacted' format. Oct 2 19:18:09.089602 kernel: Freeing SMP alternatives memory: 32K Oct 2 19:18:09.089622 kernel: pid_max: default: 32768 minimum: 301 Oct 2 19:18:09.089636 kernel: LSM: Security Framework initializing Oct 2 19:18:09.089650 kernel: SELinux: Initializing. Oct 2 19:18:09.089663 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Oct 2 19:18:09.089677 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Oct 2 19:18:09.089693 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8259CL CPU @ 2.50GHz (family: 0x6, model: 0x55, stepping: 0x7) Oct 2 19:18:09.089708 kernel: Performance Events: unsupported p6 CPU model 85 no PMU driver, software events only. Oct 2 19:18:09.089722 kernel: signal: max sigframe size: 3632 Oct 2 19:18:09.089735 kernel: rcu: Hierarchical SRCU implementation. Oct 2 19:18:09.089749 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Oct 2 19:18:09.089768 kernel: smp: Bringing up secondary CPUs ... Oct 2 19:18:09.089782 kernel: x86: Booting SMP configuration: Oct 2 19:18:09.089795 kernel: .... node #0, CPUs: #1 Oct 2 19:18:09.089808 kernel: kvm-clock: cpu 1, msr 55f8a041, secondary cpu clock Oct 2 19:18:09.089820 kernel: kvm-guest: stealtime: cpu 1, msr 7b71c0c0 Oct 2 19:18:09.089834 kernel: MDS CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/mds.html for more details. Oct 2 19:18:09.089847 kernel: MMIO Stale Data CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/processor_mmio_stale_data.html for more details. Oct 2 19:18:09.089860 kernel: smp: Brought up 1 node, 2 CPUs Oct 2 19:18:09.089872 kernel: smpboot: Max logical packages: 1 Oct 2 19:18:09.089888 kernel: smpboot: Total of 2 processors activated (10000.01 BogoMIPS) Oct 2 19:18:09.089900 kernel: devtmpfs: initialized Oct 2 19:18:09.089912 kernel: x86/mm: Memory block size: 128MB Oct 2 19:18:09.089925 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 2 19:18:09.089937 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 2 19:18:09.089950 kernel: pinctrl core: initialized pinctrl subsystem Oct 2 19:18:09.089962 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 2 19:18:09.090017 kernel: audit: initializing netlink subsys (disabled) Oct 2 19:18:09.090030 kernel: audit: type=2000 audit(1696274288.246:1): state=initialized audit_enabled=0 res=1 Oct 2 19:18:09.090046 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 2 19:18:09.090268 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 2 19:18:09.090283 kernel: cpuidle: using governor menu Oct 2 19:18:09.090295 kernel: ACPI: bus type PCI registered Oct 2 19:18:09.090309 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 2 19:18:09.090348 kernel: dca service started, version 1.12.1 Oct 2 19:18:09.090362 kernel: PCI: Using configuration type 1 for base access Oct 2 19:18:09.090377 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 2 19:18:09.090392 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Oct 2 19:18:09.090434 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Oct 2 19:18:09.090449 kernel: ACPI: Added _OSI(Module Device) Oct 2 19:18:09.090463 kernel: ACPI: Added _OSI(Processor Device) Oct 2 19:18:09.090477 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 2 19:18:09.090515 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 2 19:18:09.090529 kernel: ACPI: Added _OSI(Linux-Dell-Video) Oct 2 19:18:09.090544 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Oct 2 19:18:09.090559 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Oct 2 19:18:09.090596 kernel: ACPI: 3 ACPI AML tables successfully acquired and loaded Oct 2 19:18:09.090614 kernel: ACPI: Interpreter enabled Oct 2 19:18:09.090709 kernel: ACPI: PM: (supports S0 S5) Oct 2 19:18:09.090754 kernel: ACPI: Using IOAPIC for interrupt routing Oct 2 19:18:09.090769 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 2 19:18:09.090785 kernel: ACPI: Enabled 16 GPEs in block 00 to 0F Oct 2 19:18:09.090799 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 2 19:18:09.090990 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Oct 2 19:18:09.091133 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. Oct 2 19:18:09.091156 kernel: acpiphp: Slot [3] registered Oct 2 19:18:09.091171 kernel: acpiphp: Slot [4] registered Oct 2 19:18:09.091185 kernel: acpiphp: Slot [5] registered Oct 2 19:18:09.091200 kernel: acpiphp: Slot [6] registered Oct 2 19:18:09.091214 kernel: acpiphp: Slot [7] registered Oct 2 19:18:09.091230 kernel: acpiphp: Slot [8] registered Oct 2 19:18:09.091244 kernel: acpiphp: Slot [9] registered Oct 2 19:18:09.091259 kernel: acpiphp: Slot [10] registered Oct 2 19:18:09.091273 kernel: acpiphp: Slot [11] registered Oct 2 19:18:09.091291 kernel: acpiphp: Slot [12] registered Oct 2 19:18:09.091305 kernel: acpiphp: Slot [13] registered Oct 2 19:18:09.091320 kernel: acpiphp: Slot [14] registered Oct 2 19:18:09.091335 kernel: acpiphp: Slot [15] registered Oct 2 19:18:09.091348 kernel: acpiphp: Slot [16] registered Oct 2 19:18:09.091363 kernel: acpiphp: Slot [17] registered Oct 2 19:18:09.091378 kernel: acpiphp: Slot [18] registered Oct 2 19:18:09.091393 kernel: acpiphp: Slot [19] registered Oct 2 19:18:09.091407 kernel: acpiphp: Slot [20] registered Oct 2 19:18:09.091425 kernel: acpiphp: Slot [21] registered Oct 2 19:18:09.091440 kernel: acpiphp: Slot [22] registered Oct 2 19:18:09.091455 kernel: acpiphp: Slot [23] registered Oct 2 19:18:09.091469 kernel: acpiphp: Slot [24] registered Oct 2 19:18:09.091484 kernel: acpiphp: Slot [25] registered Oct 2 19:18:09.091498 kernel: acpiphp: Slot [26] registered Oct 2 19:18:09.091513 kernel: acpiphp: Slot [27] registered Oct 2 19:18:09.091527 kernel: acpiphp: Slot [28] registered Oct 2 19:18:09.091542 kernel: acpiphp: Slot [29] registered Oct 2 19:18:09.091559 kernel: acpiphp: Slot [30] registered Oct 2 19:18:09.091573 kernel: acpiphp: Slot [31] registered Oct 2 19:18:09.091588 kernel: PCI host bridge to bus 0000:00 Oct 2 19:18:09.091720 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 2 19:18:09.091963 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Oct 2 19:18:09.092083 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 2 19:18:09.092211 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] Oct 2 19:18:09.092346 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 2 19:18:09.092499 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Oct 2 19:18:09.092639 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Oct 2 19:18:09.092775 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x000000 Oct 2 19:18:09.092907 kernel: pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI Oct 2 19:18:09.093035 kernel: pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB Oct 2 19:18:09.093210 kernel: pci 0000:00:01.3: PIIX4 devres E PIO at fff0-ffff Oct 2 19:18:09.093336 kernel: pci 0000:00:01.3: PIIX4 devres F MMIO at ffc00000-ffffffff Oct 2 19:18:09.093594 kernel: pci 0000:00:01.3: PIIX4 devres G PIO at fff0-ffff Oct 2 19:18:09.093723 kernel: pci 0000:00:01.3: PIIX4 devres H MMIO at ffc00000-ffffffff Oct 2 19:18:09.093844 kernel: pci 0000:00:01.3: PIIX4 devres I PIO at fff0-ffff Oct 2 19:18:09.093959 kernel: pci 0000:00:01.3: PIIX4 devres J PIO at fff0-ffff Oct 2 19:18:09.094076 kernel: pci 0000:00:01.3: quirk_piix4_acpi+0x0/0x170 took 12695 usecs Oct 2 19:18:09.094216 kernel: pci 0000:00:03.0: [1d0f:1111] type 00 class 0x030000 Oct 2 19:18:09.094402 kernel: pci 0000:00:03.0: reg 0x10: [mem 0xfe400000-0xfe7fffff pref] Oct 2 19:18:09.094526 kernel: pci 0000:00:03.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] Oct 2 19:18:09.094641 kernel: pci 0000:00:03.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Oct 2 19:18:09.094830 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Oct 2 19:18:09.095020 kernel: pci 0000:00:04.0: reg 0x10: [mem 0xfebf0000-0xfebf3fff] Oct 2 19:18:09.095159 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Oct 2 19:18:09.096448 kernel: pci 0000:00:05.0: reg 0x10: [mem 0xfebf4000-0xfebf7fff] Oct 2 19:18:09.096484 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Oct 2 19:18:09.096500 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Oct 2 19:18:09.096517 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Oct 2 19:18:09.096532 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Oct 2 19:18:09.096548 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Oct 2 19:18:09.096563 kernel: iommu: Default domain type: Translated Oct 2 19:18:09.096579 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 2 19:18:09.096724 kernel: pci 0000:00:03.0: vgaarb: setting as boot VGA device Oct 2 19:18:09.096939 kernel: pci 0000:00:03.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Oct 2 19:18:09.097107 kernel: pci 0000:00:03.0: vgaarb: bridge control possible Oct 2 19:18:09.097128 kernel: vgaarb: loaded Oct 2 19:18:09.097145 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 2 19:18:09.097161 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 2 19:18:09.097177 kernel: PTP clock support registered Oct 2 19:18:09.097192 kernel: PCI: Using ACPI for IRQ routing Oct 2 19:18:09.097207 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 2 19:18:09.097224 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Oct 2 19:18:09.097243 kernel: e820: reserve RAM buffer [mem 0x7d9ea000-0x7fffffff] Oct 2 19:18:09.097257 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0 Oct 2 19:18:09.097272 kernel: hpet0: 8 comparators, 32-bit 62.500000 MHz counter Oct 2 19:18:09.097287 kernel: clocksource: Switched to clocksource kvm-clock Oct 2 19:18:09.097302 kernel: VFS: Disk quotas dquot_6.6.0 Oct 2 19:18:09.097318 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 2 19:18:09.097333 kernel: pnp: PnP ACPI init Oct 2 19:18:09.097349 kernel: pnp: PnP ACPI: found 5 devices Oct 2 19:18:09.097365 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 2 19:18:09.097384 kernel: NET: Registered PF_INET protocol family Oct 2 19:18:09.097400 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 2 19:18:09.097415 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Oct 2 19:18:09.097432 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 2 19:18:09.097496 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 2 19:18:09.097513 kernel: TCP bind hash table entries: 16384 (order: 6, 262144 bytes, linear) Oct 2 19:18:09.097528 kernel: TCP: Hash tables configured (established 16384 bind 16384) Oct 2 19:18:09.097543 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Oct 2 19:18:09.097559 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Oct 2 19:18:09.097578 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 2 19:18:09.097593 kernel: NET: Registered PF_XDP protocol family Oct 2 19:18:09.097732 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 2 19:18:09.097843 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Oct 2 19:18:09.097956 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Oct 2 19:18:09.098097 kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] Oct 2 19:18:09.098250 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Oct 2 19:18:09.098385 kernel: pci 0000:00:01.0: Activating ISA DMA hang workarounds Oct 2 19:18:09.098404 kernel: PCI: CLS 0 bytes, default 64 Oct 2 19:18:09.098420 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Oct 2 19:18:09.098435 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x24093d6e846, max_idle_ns: 440795249997 ns Oct 2 19:18:09.098450 kernel: clocksource: Switched to clocksource tsc Oct 2 19:18:09.098464 kernel: Initialise system trusted keyrings Oct 2 19:18:09.098477 kernel: workingset: timestamp_bits=39 max_order=19 bucket_order=0 Oct 2 19:18:09.098490 kernel: Key type asymmetric registered Oct 2 19:18:09.098503 kernel: Asymmetric key parser 'x509' registered Oct 2 19:18:09.098520 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 2 19:18:09.098533 kernel: io scheduler mq-deadline registered Oct 2 19:18:09.098546 kernel: io scheduler kyber registered Oct 2 19:18:09.098560 kernel: io scheduler bfq registered Oct 2 19:18:09.098573 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 2 19:18:09.098587 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 2 19:18:09.098600 kernel: 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 2 19:18:09.098615 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Oct 2 19:18:09.098628 kernel: i8042: Warning: Keylock active Oct 2 19:18:09.098645 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Oct 2 19:18:09.098659 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Oct 2 19:18:09.098789 kernel: rtc_cmos 00:00: RTC can wake from S4 Oct 2 19:18:09.098903 kernel: rtc_cmos 00:00: registered as rtc0 Oct 2 19:18:09.099016 kernel: rtc_cmos 00:00: setting system clock to 2023-10-02T19:18:08 UTC (1696274288) Oct 2 19:18:09.099144 kernel: rtc_cmos 00:00: alarms up to one day, 114 bytes nvram Oct 2 19:18:09.099162 kernel: intel_pstate: CPU model not supported Oct 2 19:18:09.099176 kernel: NET: Registered PF_INET6 protocol family Oct 2 19:18:09.099195 kernel: Segment Routing with IPv6 Oct 2 19:18:09.099209 kernel: In-situ OAM (IOAM) with IPv6 Oct 2 19:18:09.099223 kernel: NET: Registered PF_PACKET protocol family Oct 2 19:18:09.099238 kernel: Key type dns_resolver registered Oct 2 19:18:09.099252 kernel: IPI shorthand broadcast: enabled Oct 2 19:18:09.099267 kernel: sched_clock: Marking stable (543410107, 436422341)->(1127923003, -148090555) Oct 2 19:18:09.099281 kernel: registered taskstats version 1 Oct 2 19:18:09.099296 kernel: Loading compiled-in X.509 certificates Oct 2 19:18:09.099310 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.132-flatcar: 6f9e51af8b3ef67eb6e93ecfe77d55665ad3d861' Oct 2 19:18:09.099328 kernel: Key type .fscrypt registered Oct 2 19:18:09.099342 kernel: Key type fscrypt-provisioning registered Oct 2 19:18:09.099356 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 2 19:18:09.099371 kernel: ima: Allocated hash algorithm: sha1 Oct 2 19:18:09.099386 kernel: ima: No architecture policies found Oct 2 19:18:09.099400 kernel: Freeing unused kernel image (initmem) memory: 45372K Oct 2 19:18:09.099414 kernel: Write protecting the kernel read-only data: 28672k Oct 2 19:18:09.099430 kernel: Freeing unused kernel image (text/rodata gap) memory: 2040K Oct 2 19:18:09.099447 kernel: Freeing unused kernel image (rodata/data gap) memory: 644K Oct 2 19:18:09.099462 kernel: Run /init as init process Oct 2 19:18:09.099477 kernel: with arguments: Oct 2 19:18:09.099491 kernel: /init Oct 2 19:18:09.099506 kernel: with environment: Oct 2 19:18:09.099520 kernel: HOME=/ Oct 2 19:18:09.099533 kernel: TERM=linux Oct 2 19:18:09.099548 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 2 19:18:09.099566 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 19:18:09.099587 systemd[1]: Detected virtualization amazon. Oct 2 19:18:09.099603 systemd[1]: Detected architecture x86-64. Oct 2 19:18:09.099618 systemd[1]: Running in initrd. Oct 2 19:18:09.099634 systemd[1]: No hostname configured, using default hostname. Oct 2 19:18:09.099666 systemd[1]: Hostname set to . Oct 2 19:18:09.099688 systemd[1]: Initializing machine ID from VM UUID. Oct 2 19:18:09.099704 systemd[1]: Queued start job for default target initrd.target. Oct 2 19:18:09.099720 systemd[1]: Started systemd-ask-password-console.path. Oct 2 19:18:09.099736 systemd[1]: Reached target cryptsetup.target. Oct 2 19:18:09.099752 systemd[1]: Reached target paths.target. Oct 2 19:18:09.099767 systemd[1]: Reached target slices.target. Oct 2 19:18:09.099783 systemd[1]: Reached target swap.target. Oct 2 19:18:09.099798 systemd[1]: Reached target timers.target. Oct 2 19:18:09.099817 systemd[1]: Listening on iscsid.socket. Oct 2 19:18:09.099834 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Oct 2 19:18:09.099852 systemd[1]: Listening on iscsiuio.socket. Oct 2 19:18:09.099869 systemd[1]: Listening on systemd-journald-audit.socket. Oct 2 19:18:09.099886 systemd[1]: Listening on systemd-journald-dev-log.socket. Oct 2 19:18:09.099902 systemd[1]: Listening on systemd-journald.socket. Oct 2 19:18:09.099917 systemd[1]: Listening on systemd-networkd.socket. Oct 2 19:18:09.099932 systemd[1]: Listening on systemd-udevd-control.socket. Oct 2 19:18:09.099949 systemd[1]: Listening on systemd-udevd-kernel.socket. Oct 2 19:18:09.099964 systemd[1]: Reached target sockets.target. Oct 2 19:18:09.099979 systemd[1]: Starting kmod-static-nodes.service... Oct 2 19:18:09.099994 systemd[1]: Finished network-cleanup.service. Oct 2 19:18:09.100009 systemd[1]: Starting systemd-fsck-usr.service... Oct 2 19:18:09.100025 systemd[1]: Starting systemd-journald.service... Oct 2 19:18:09.100040 systemd[1]: Starting systemd-modules-load.service... Oct 2 19:18:09.100055 systemd[1]: Starting systemd-resolved.service... Oct 2 19:18:09.100069 systemd[1]: Starting systemd-vconsole-setup.service... Oct 2 19:18:09.100107 systemd-journald[185]: Journal started Oct 2 19:18:09.100181 systemd-journald[185]: Runtime Journal (/run/log/journal/ec25189e55c6b9ad04df8098a5ba0633) is 4.8M, max 38.7M, 33.9M free. Oct 2 19:18:09.108129 systemd[1]: Started systemd-journald.service. Oct 2 19:18:09.131143 systemd-modules-load[186]: Inserted module 'overlay' Oct 2 19:18:09.293570 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 19:18:09.293611 kernel: Bridge firewalling registered Oct 2 19:18:09.293629 kernel: SCSI subsystem initialized Oct 2 19:18:09.293645 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 2 19:18:09.293668 kernel: device-mapper: uevent: version 1.0.3 Oct 2 19:18:09.293688 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Oct 2 19:18:09.293708 kernel: audit: type=1130 audit(1696274289.286:2): 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 19:18:09.286000 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 19:18:09.138330 systemd-resolved[187]: Positive Trust Anchors: Oct 2 19:18:09.293000 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 19:18:09.138346 systemd-resolved[187]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 2 19:18:09.303995 kernel: audit: type=1130 audit(1696274289.293:3): 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 19:18:09.304028 kernel: audit: type=1130 audit(1696274289.294:4): 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 19:18:09.294000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 19:18:09.138401 systemd-resolved[187]: 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 19:18:09.319068 kernel: audit: type=1130 audit(1696274289.306:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 19:18:09.306000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 19:18:09.142132 systemd-resolved[187]: Defaulting to hostname 'linux'. Oct 2 19:18:09.180194 systemd-modules-load[186]: Inserted module 'br_netfilter' Oct 2 19:18:09.225191 systemd-modules-load[186]: Inserted module 'dm_multipath' Oct 2 19:18:09.286661 systemd[1]: Started systemd-resolved.service. Oct 2 19:18:09.325000 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 19:18:09.293901 systemd[1]: Finished kmod-static-nodes.service. Oct 2 19:18:09.332741 kernel: audit: type=1130 audit(1696274289.325:6): 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 19:18:09.295353 systemd[1]: Finished systemd-fsck-usr.service. Oct 2 19:18:09.323456 systemd[1]: Finished systemd-modules-load.service. Oct 2 19:18:09.326610 systemd[1]: Finished systemd-vconsole-setup.service. Oct 2 19:18:09.339000 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 19:18:09.340143 systemd[1]: Reached target nss-lookup.target. Oct 2 19:18:09.353452 kernel: audit: type=1130 audit(1696274289.339:7): 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 19:18:09.354439 systemd[1]: Starting dracut-cmdline-ask.service... Oct 2 19:18:09.356783 systemd[1]: Starting systemd-sysctl.service... Oct 2 19:18:09.365202 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Oct 2 19:18:09.394314 systemd[1]: Finished systemd-sysctl.service. Oct 2 19:18:09.397000 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 19:18:09.415112 kernel: audit: type=1130 audit(1696274289.397:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 19:18:09.417915 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Oct 2 19:18:09.417000 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 19:18:09.438132 kernel: audit: type=1130 audit(1696274289.417:9): 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 19:18:09.445683 systemd[1]: Finished dracut-cmdline-ask.service. Oct 2 19:18:09.446000 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 19:18:09.456247 kernel: audit: type=1130 audit(1696274289.446:10): 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 19:18:09.448252 systemd[1]: Starting dracut-cmdline.service... Oct 2 19:18:09.464513 dracut-cmdline[206]: dracut-dracut-053 Oct 2 19:18:09.468130 dracut-cmdline[206]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro 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=ttyS0,115200n8 flatcar.first_boot=detected flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=96b0fdb9f11bf1422adc9955c78c8182df387766badfd0b94e08fb9688739ee1 Oct 2 19:18:09.552220 kernel: Loading iSCSI transport class v2.0-870. Oct 2 19:18:09.568183 kernel: iscsi: registered transport (tcp) Oct 2 19:18:09.596888 kernel: iscsi: registered transport (qla4xxx) Oct 2 19:18:09.596958 kernel: QLogic iSCSI HBA Driver Oct 2 19:18:09.662936 systemd[1]: Finished dracut-cmdline.service. Oct 2 19:18:09.668412 systemd[1]: Starting dracut-pre-udev.service... Oct 2 19:18:09.663000 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 19:18:09.728114 kernel: raid6: avx512x4 gen() 17920 MB/s Oct 2 19:18:09.745112 kernel: raid6: avx512x4 xor() 7252 MB/s Oct 2 19:18:09.763116 kernel: raid6: avx512x2 gen() 16023 MB/s Oct 2 19:18:09.780117 kernel: raid6: avx512x2 xor() 22568 MB/s Oct 2 19:18:09.798118 kernel: raid6: avx512x1 gen() 15793 MB/s Oct 2 19:18:09.816119 kernel: raid6: avx512x1 xor() 19092 MB/s Oct 2 19:18:09.834118 kernel: raid6: avx2x4 gen() 16277 MB/s Oct 2 19:18:09.852285 kernel: raid6: avx2x4 xor() 7393 MB/s Oct 2 19:18:09.870116 kernel: raid6: avx2x2 gen() 16776 MB/s Oct 2 19:18:09.888120 kernel: raid6: avx2x2 xor() 15065 MB/s Oct 2 19:18:09.906117 kernel: raid6: avx2x1 gen() 13268 MB/s Oct 2 19:18:09.924158 kernel: raid6: avx2x1 xor() 12845 MB/s Oct 2 19:18:09.942117 kernel: raid6: sse2x4 gen() 7839 MB/s Oct 2 19:18:09.959113 kernel: raid6: sse2x4 xor() 5417 MB/s Oct 2 19:18:09.977138 kernel: raid6: sse2x2 gen() 10048 MB/s Oct 2 19:18:09.994115 kernel: raid6: sse2x2 xor() 5561 MB/s Oct 2 19:18:10.012112 kernel: raid6: sse2x1 gen() 8255 MB/s Oct 2 19:18:10.030824 kernel: raid6: sse2x1 xor() 4683 MB/s Oct 2 19:18:10.030893 kernel: raid6: using algorithm avx512x4 gen() 17920 MB/s Oct 2 19:18:10.030921 kernel: raid6: .... xor() 7252 MB/s, rmw enabled Oct 2 19:18:10.031998 kernel: raid6: using avx512x2 recovery algorithm Oct 2 19:18:10.047111 kernel: xor: automatically using best checksumming function avx Oct 2 19:18:10.158114 kernel: Btrfs loaded, crc32c=crc32c-intel, zoned=no, fsverity=no Oct 2 19:18:10.167714 systemd[1]: Finished dracut-pre-udev.service. Oct 2 19:18:10.169000 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 19:18:10.170000 audit: BPF prog-id=7 op=LOAD Oct 2 19:18:10.170817 systemd[1]: Starting systemd-udevd.service... Oct 2 19:18:10.170000 audit: BPF prog-id=8 op=LOAD Oct 2 19:18:10.188975 systemd-udevd[385]: Using default interface naming scheme 'v252'. Oct 2 19:18:10.200173 systemd[1]: Started systemd-udevd.service. Oct 2 19:18:10.202000 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 19:18:10.205917 systemd[1]: Starting dracut-pre-trigger.service... Oct 2 19:18:10.236573 dracut-pre-trigger[395]: rd.md=0: removing MD RAID activation Oct 2 19:18:10.291741 systemd[1]: Finished dracut-pre-trigger.service. Oct 2 19:18:10.292000 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 19:18:10.294210 systemd[1]: Starting systemd-udev-trigger.service... Oct 2 19:18:10.367868 systemd[1]: Finished systemd-udev-trigger.service. Oct 2 19:18:10.369000 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 19:18:10.460210 kernel: cryptd: max_cpu_qlen set to 1000 Oct 2 19:18:10.460276 kernel: ena 0000:00:05.0: ENA device version: 0.10 Oct 2 19:18:10.460511 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Oct 2 19:18:10.473122 kernel: ena 0000:00:05.0: LLQ is not supported Fallback to host mode policy. Oct 2 19:18:10.478137 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem febf4000, mac addr 06:82:61:34:20:37 Oct 2 19:18:10.480310 (udev-worker)[440]: Network interface NamePolicy= disabled on kernel command line. Oct 2 19:18:10.802962 kernel: AVX2 version of gcm_enc/dec engaged. Oct 2 19:18:10.803007 kernel: AES CTR mode by8 optimization enabled Oct 2 19:18:10.803025 kernel: nvme nvme0: pci function 0000:00:04.0 Oct 2 19:18:10.803328 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11 Oct 2 19:18:10.803349 kernel: nvme nvme0: 2/0/0 default/read/poll queues Oct 2 19:18:10.803485 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 2 19:18:10.803503 kernel: GPT:9289727 != 16777215 Oct 2 19:18:10.803519 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 2 19:18:10.803536 kernel: GPT:9289727 != 16777215 Oct 2 19:18:10.803557 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 2 19:18:10.803574 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 2 19:18:10.803591 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by (udev-worker) (435) Oct 2 19:18:10.701718 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Oct 2 19:18:10.814530 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Oct 2 19:18:10.822433 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Oct 2 19:18:10.845250 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Oct 2 19:18:10.846720 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Oct 2 19:18:10.851319 systemd[1]: Starting disk-uuid.service... Oct 2 19:18:10.861781 disk-uuid[585]: Primary Header is updated. Oct 2 19:18:10.861781 disk-uuid[585]: Secondary Entries is updated. Oct 2 19:18:10.861781 disk-uuid[585]: Secondary Header is updated. Oct 2 19:18:10.868110 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 2 19:18:10.875111 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 2 19:18:10.883130 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 2 19:18:11.882053 disk-uuid[586]: The operation has completed successfully. Oct 2 19:18:11.883965 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 2 19:18:12.023318 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 2 19:18:12.023000 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 19:18:12.023000 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 19:18:12.023430 systemd[1]: Finished disk-uuid.service. Oct 2 19:18:12.036455 systemd[1]: Starting verity-setup.service... Oct 2 19:18:12.085132 kernel: device-mapper: verity: sha256 using implementation "sha256-generic" Oct 2 19:18:12.174149 systemd[1]: Found device dev-mapper-usr.device. Oct 2 19:18:12.179991 systemd[1]: Mounting sysusr-usr.mount... Oct 2 19:18:12.186177 systemd[1]: Finished verity-setup.service. Oct 2 19:18:12.189000 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 19:18:12.294114 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Oct 2 19:18:12.295212 systemd[1]: Mounted sysusr-usr.mount. Oct 2 19:18:12.295675 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Oct 2 19:18:12.296921 systemd[1]: Starting ignition-setup.service... Oct 2 19:18:12.312446 systemd[1]: Starting parse-ip-for-networkd.service... Oct 2 19:18:12.329416 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Oct 2 19:18:12.329475 kernel: BTRFS info (device nvme0n1p6): using free space tree Oct 2 19:18:12.329494 kernel: BTRFS info (device nvme0n1p6): has skinny extents Oct 2 19:18:12.339010 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 2 19:18:12.351176 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 2 19:18:12.370593 systemd[1]: Finished ignition-setup.service. Oct 2 19:18:12.371000 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 19:18:12.372935 systemd[1]: Starting ignition-fetch-offline.service... Oct 2 19:18:12.416648 systemd[1]: Finished parse-ip-for-networkd.service. Oct 2 19:18:12.418000 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 19:18:12.420000 audit: BPF prog-id=9 op=LOAD Oct 2 19:18:12.421265 systemd[1]: Starting systemd-networkd.service... Oct 2 19:18:12.463765 systemd-networkd[1098]: lo: Link UP Oct 2 19:18:12.463776 systemd-networkd[1098]: lo: Gained carrier Oct 2 19:18:12.464394 systemd-networkd[1098]: Enumeration completed Oct 2 19:18:12.464646 systemd-networkd[1098]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 2 19:18:12.466664 systemd[1]: Started systemd-networkd.service. Oct 2 19:18:12.472000 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 19:18:12.472426 systemd[1]: Reached target network.target. Oct 2 19:18:12.475048 systemd[1]: Starting iscsiuio.service... Oct 2 19:18:12.481076 systemd-networkd[1098]: eth0: Link UP Oct 2 19:18:12.482743 systemd-networkd[1098]: eth0: Gained carrier Oct 2 19:18:12.487236 systemd[1]: Started iscsiuio.service. Oct 2 19:18:12.489000 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 19:18:12.491335 systemd[1]: Starting iscsid.service... Oct 2 19:18:12.496993 iscsid[1103]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Oct 2 19:18:12.496993 iscsid[1103]: 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 19:18:12.496993 iscsid[1103]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Oct 2 19:18:12.496993 iscsid[1103]: If using hardware iscsi like qla4xxx this message can be ignored. Oct 2 19:18:12.496993 iscsid[1103]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Oct 2 19:18:12.516000 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 19:18:12.523206 iscsid[1103]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Oct 2 19:18:12.503183 systemd[1]: Started iscsid.service. Oct 2 19:18:12.509328 systemd-networkd[1098]: eth0: DHCPv4 address 172.31.16.170/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 2 19:18:12.520768 systemd[1]: Starting dracut-initqueue.service... Oct 2 19:18:12.536940 systemd[1]: Finished dracut-initqueue.service. Oct 2 19:18:12.539000 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 19:18:12.539947 systemd[1]: Reached target remote-fs-pre.target. Oct 2 19:18:12.540028 systemd[1]: Reached target remote-cryptsetup.target. Oct 2 19:18:12.543964 systemd[1]: Reached target remote-fs.target. Oct 2 19:18:12.548632 systemd[1]: Starting dracut-pre-mount.service... Oct 2 19:18:12.561412 systemd[1]: Finished dracut-pre-mount.service. Oct 2 19:18:12.562000 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 19:18:12.877396 ignition[1048]: Ignition 2.14.0 Oct 2 19:18:12.877414 ignition[1048]: Stage: fetch-offline Oct 2 19:18:12.877559 ignition[1048]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 19:18:12.877614 ignition[1048]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 19:18:12.901744 ignition[1048]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 19:18:12.903351 ignition[1048]: Ignition finished successfully Oct 2 19:18:12.905581 systemd[1]: Finished ignition-fetch-offline.service. Oct 2 19:18:12.907000 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 19:18:12.909238 systemd[1]: Starting ignition-fetch.service... Oct 2 19:18:12.937877 ignition[1122]: Ignition 2.14.0 Oct 2 19:18:12.937893 ignition[1122]: Stage: fetch Oct 2 19:18:12.938369 ignition[1122]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 19:18:12.938431 ignition[1122]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 19:18:12.948007 ignition[1122]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 19:18:12.949565 ignition[1122]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 19:18:12.976185 ignition[1122]: INFO : PUT result: OK Oct 2 19:18:12.979874 ignition[1122]: DEBUG : parsed url from cmdline: "" Oct 2 19:18:12.979874 ignition[1122]: INFO : no config URL provided Oct 2 19:18:12.979874 ignition[1122]: INFO : reading system config file "/usr/lib/ignition/user.ign" Oct 2 19:18:12.979874 ignition[1122]: INFO : no config at "/usr/lib/ignition/user.ign" Oct 2 19:18:12.985234 ignition[1122]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 19:18:12.985234 ignition[1122]: INFO : PUT result: OK Oct 2 19:18:12.985234 ignition[1122]: INFO : GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Oct 2 19:18:12.989764 ignition[1122]: INFO : GET result: OK Oct 2 19:18:12.989764 ignition[1122]: DEBUG : parsing config with SHA512: 36aa53d999abba516e5286da6411545fa2a43dfbfb55c1acf02b5de4bafddd6b96041f9559342657c02c4c573704b0b7aeb175ee89e370b1b7fde2659ba95840 Oct 2 19:18:12.988508 ignition[1122]: fetch: fetch complete Oct 2 19:18:12.987971 unknown[1122]: fetched base config from "system" Oct 2 19:18:12.998000 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 19:18:12.988515 ignition[1122]: fetch: fetch passed Oct 2 19:18:12.987981 unknown[1122]: fetched base config from "system" Oct 2 19:18:12.988562 ignition[1122]: Ignition finished successfully Oct 2 19:18:12.987989 unknown[1122]: fetched user config from "aws" Oct 2 19:18:12.992290 systemd[1]: Finished ignition-fetch.service. Oct 2 19:18:13.000314 systemd[1]: Starting ignition-kargs.service... Oct 2 19:18:13.015634 ignition[1128]: Ignition 2.14.0 Oct 2 19:18:13.015647 ignition[1128]: Stage: kargs Oct 2 19:18:13.015845 ignition[1128]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 19:18:13.015878 ignition[1128]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 19:18:13.027648 ignition[1128]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 19:18:13.029368 ignition[1128]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 19:18:13.031327 ignition[1128]: INFO : PUT result: OK Oct 2 19:18:13.034576 ignition[1128]: kargs: kargs passed Oct 2 19:18:13.034642 ignition[1128]: Ignition finished successfully Oct 2 19:18:13.037124 systemd[1]: Finished ignition-kargs.service. Oct 2 19:18:13.038000 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 19:18:13.040471 systemd[1]: Starting ignition-disks.service... Oct 2 19:18:13.050729 ignition[1134]: Ignition 2.14.0 Oct 2 19:18:13.050739 ignition[1134]: Stage: disks Oct 2 19:18:13.051032 ignition[1134]: reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 19:18:13.051057 ignition[1134]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 19:18:13.060360 ignition[1134]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 19:18:13.062071 ignition[1134]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 19:18:13.063863 ignition[1134]: INFO : PUT result: OK Oct 2 19:18:13.068210 ignition[1134]: disks: disks passed Oct 2 19:18:13.068269 ignition[1134]: Ignition finished successfully Oct 2 19:18:13.070153 systemd[1]: Finished ignition-disks.service. Oct 2 19:18:13.074388 systemd[1]: Reached target initrd-root-device.target. Oct 2 19:18:13.084184 kernel: kauditd_printk_skb: 21 callbacks suppressed Oct 2 19:18:13.084223 kernel: audit: type=1130 audit(1696274293.074:32): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 19:18:13.074000 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 19:18:13.074479 systemd[1]: Reached target local-fs-pre.target. Oct 2 19:18:13.084151 systemd[1]: Reached target local-fs.target. Oct 2 19:18:13.085706 systemd[1]: Reached target sysinit.target. Oct 2 19:18:13.086755 systemd[1]: Reached target basic.target. Oct 2 19:18:13.087694 systemd[1]: Starting systemd-fsck-root.service... Oct 2 19:18:13.117474 systemd-fsck[1142]: ROOT: clean, 603/553520 files, 56012/553472 blocks Oct 2 19:18:13.122283 systemd[1]: Finished systemd-fsck-root.service. Oct 2 19:18:13.123000 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 19:18:13.124986 systemd[1]: Mounting sysroot.mount... Oct 2 19:18:13.138135 kernel: audit: type=1130 audit(1696274293.123:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 19:18:13.147158 kernel: EXT4-fs (nvme0n1p9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Oct 2 19:18:13.147686 systemd[1]: Mounted sysroot.mount. Oct 2 19:18:13.156500 systemd[1]: Reached target initrd-root-fs.target. Oct 2 19:18:13.160800 systemd[1]: Mounting sysroot-usr.mount... Oct 2 19:18:13.165391 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Oct 2 19:18:13.165784 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 2 19:18:13.165825 systemd[1]: Reached target ignition-diskful.target. Oct 2 19:18:13.178398 systemd[1]: Mounted sysroot-usr.mount. Oct 2 19:18:13.180189 systemd[1]: Starting initrd-setup-root.service... Oct 2 19:18:13.189258 initrd-setup-root[1163]: cut: /sysroot/etc/passwd: No such file or directory Oct 2 19:18:13.210335 systemd[1]: Mounting sysroot-usr-share-oem.mount... Oct 2 19:18:13.216639 initrd-setup-root[1172]: cut: /sysroot/etc/group: No such file or directory Oct 2 19:18:13.225896 initrd-setup-root[1180]: cut: /sysroot/etc/shadow: No such file or directory Oct 2 19:18:13.240730 initrd-setup-root[1188]: cut: /sysroot/etc/gshadow: No such file or directory Oct 2 19:18:13.242516 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/nvme0n1p6 scanned by mount (1170) Oct 2 19:18:13.247011 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Oct 2 19:18:13.247066 kernel: BTRFS info (device nvme0n1p6): using free space tree Oct 2 19:18:13.247096 kernel: BTRFS info (device nvme0n1p6): has skinny extents Oct 2 19:18:13.269146 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 2 19:18:13.275105 systemd[1]: Mounted sysroot-usr-share-oem.mount. Oct 2 19:18:13.363383 systemd[1]: Finished initrd-setup-root.service. Oct 2 19:18:13.365000 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 19:18:13.366441 systemd[1]: Starting ignition-mount.service... Oct 2 19:18:13.374208 kernel: audit: type=1130 audit(1696274293.365:34): 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 19:18:13.381237 systemd[1]: Starting sysroot-boot.service... Oct 2 19:18:13.391626 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. Oct 2 19:18:13.391754 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. Oct 2 19:18:13.408516 ignition[1224]: INFO : Ignition 2.14.0 Oct 2 19:18:13.409787 ignition[1224]: INFO : Stage: mount Oct 2 19:18:13.411079 ignition[1224]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 19:18:13.412911 ignition[1224]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 19:18:13.424818 ignition[1224]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 19:18:13.427123 ignition[1224]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 19:18:13.429501 ignition[1224]: INFO : PUT result: OK Oct 2 19:18:13.432246 systemd[1]: Finished sysroot-boot.service. Oct 2 19:18:13.443309 kernel: audit: type=1130 audit(1696274293.434:35): 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 19:18:13.434000 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 19:18:13.443971 ignition[1224]: INFO : mount: mount passed Oct 2 19:18:13.445106 ignition[1224]: INFO : Ignition finished successfully Oct 2 19:18:13.445942 systemd[1]: Finished ignition-mount.service. Oct 2 19:18:13.453889 kernel: audit: type=1130 audit(1696274293.447:36): 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 19:18:13.447000 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 19:18:13.454776 systemd[1]: Starting ignition-files.service... Oct 2 19:18:13.464405 systemd[1]: Mounting sysroot-usr-share-oem.mount... Oct 2 19:18:13.477114 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 scanned by mount (1234) Oct 2 19:18:13.480977 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Oct 2 19:18:13.481053 kernel: BTRFS info (device nvme0n1p6): using free space tree Oct 2 19:18:13.481072 kernel: BTRFS info (device nvme0n1p6): has skinny extents Oct 2 19:18:13.488109 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 2 19:18:13.491127 systemd[1]: Mounted sysroot-usr-share-oem.mount. Oct 2 19:18:13.508176 ignition[1253]: INFO : Ignition 2.14.0 Oct 2 19:18:13.508176 ignition[1253]: INFO : Stage: files Oct 2 19:18:13.510853 ignition[1253]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 19:18:13.510853 ignition[1253]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 19:18:13.522436 ignition[1253]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 19:18:13.524222 ignition[1253]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 19:18:13.527165 ignition[1253]: INFO : PUT result: OK Oct 2 19:18:13.534305 ignition[1253]: DEBUG : files: compiled without relabeling support, skipping Oct 2 19:18:13.536361 ignition[1253]: INFO : files: createFilesystemsFiles: createFiles: op(1): [started] writing file "/sysroot/etc/eks/bootstrap.sh" Oct 2 19:18:13.540011 ignition[1253]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Oct 2 19:18:13.549856 ignition[1253]: INFO : op(1): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1146506708" Oct 2 19:18:13.556254 kernel: BTRFS info: devid 1 device path /dev/nvme0n1p6 changed to /dev/disk/by-label/OEM scanned by ignition (1256) Oct 2 19:18:13.556289 ignition[1253]: CRITICAL : op(1): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1146506708": device or resource busy Oct 2 19:18:13.556289 ignition[1253]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem1146506708", trying btrfs: device or resource busy Oct 2 19:18:13.556289 ignition[1253]: INFO : op(2): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1146506708" Oct 2 19:18:13.556289 ignition[1253]: INFO : op(2): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem1146506708" Oct 2 19:18:13.565742 ignition[1253]: INFO : op(3): [started] unmounting "/mnt/oem1146506708" Oct 2 19:18:13.567525 ignition[1253]: INFO : op(3): [finished] unmounting "/mnt/oem1146506708" Oct 2 19:18:13.567525 ignition[1253]: INFO : files: createFilesystemsFiles: createFiles: op(1): [finished] writing file "/sysroot/etc/eks/bootstrap.sh" Oct 2 19:18:13.567525 ignition[1253]: INFO : files: createFilesystemsFiles: createFiles: op(2): [started] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Oct 2 19:18:13.576834 ignition[1253]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Oct 2 19:18:13.584359 ignition[1253]: INFO : op(4): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2452685889" Oct 2 19:18:13.584359 ignition[1253]: CRITICAL : op(4): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2452685889": device or resource busy Oct 2 19:18:13.584359 ignition[1253]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2452685889", trying btrfs: device or resource busy Oct 2 19:18:13.584359 ignition[1253]: INFO : op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2452685889" Oct 2 19:18:13.594105 ignition[1253]: INFO : op(5): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2452685889" Oct 2 19:18:13.594105 ignition[1253]: INFO : op(6): [started] unmounting "/mnt/oem2452685889" Oct 2 19:18:13.594105 ignition[1253]: INFO : op(6): [finished] unmounting "/mnt/oem2452685889" Oct 2 19:18:13.594105 ignition[1253]: INFO : files: createFilesystemsFiles: createFiles: op(2): [finished] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Oct 2 19:18:13.602815 ignition[1253]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Oct 2 19:18:13.602815 ignition[1253]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Oct 2 19:18:13.616734 ignition[1253]: INFO : op(7): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem110595199" Oct 2 19:18:13.619634 ignition[1253]: CRITICAL : op(7): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem110595199": device or resource busy Oct 2 19:18:13.619634 ignition[1253]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem110595199", trying btrfs: device or resource busy Oct 2 19:18:13.619634 ignition[1253]: INFO : op(8): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem110595199" Oct 2 19:18:13.619634 ignition[1253]: INFO : op(8): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem110595199" Oct 2 19:18:13.632329 ignition[1253]: INFO : op(9): [started] unmounting "/mnt/oem110595199" Oct 2 19:18:13.632329 ignition[1253]: INFO : op(9): [finished] unmounting "/mnt/oem110595199" Oct 2 19:18:13.632329 ignition[1253]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Oct 2 19:18:13.632329 ignition[1253]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" Oct 2 19:18:13.632329 ignition[1253]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Oct 2 19:18:13.664251 ignition[1253]: INFO : op(a): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem635763633" Oct 2 19:18:13.664251 ignition[1253]: CRITICAL : op(a): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem635763633": device or resource busy Oct 2 19:18:13.664251 ignition[1253]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem635763633", trying btrfs: device or resource busy Oct 2 19:18:13.664251 ignition[1253]: INFO : op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem635763633" Oct 2 19:18:13.675131 ignition[1253]: INFO : op(b): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem635763633" Oct 2 19:18:13.675131 ignition[1253]: INFO : op(c): [started] unmounting "/mnt/oem635763633" Oct 2 19:18:13.675131 ignition[1253]: INFO : op(c): [finished] unmounting "/mnt/oem635763633" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(5): [started] processing unit "coreos-metadata-sshkeys@.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(5): [finished] processing unit "coreos-metadata-sshkeys@.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(6): [started] processing unit "amazon-ssm-agent.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(6): op(7): [started] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(6): op(7): [finished] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(6): [finished] processing unit "amazon-ssm-agent.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(8): [started] processing unit "nvidia.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(8): [finished] processing unit "nvidia.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(9): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service " Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(9): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service " Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(a): [started] setting preset to enabled for "amazon-ssm-agent.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(a): [finished] setting preset to enabled for "amazon-ssm-agent.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(b): [started] setting preset to enabled for "nvidia.service" Oct 2 19:18:13.675131 ignition[1253]: INFO : files: op(b): [finished] setting preset to enabled for "nvidia.service" Oct 2 19:18:13.736780 kernel: audit: type=1130 audit(1696274293.706:37): 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 19:18:13.706000 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 19:18:13.736904 ignition[1253]: INFO : files: createResultFile: createFiles: op(c): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 2 19:18:13.736904 ignition[1253]: INFO : files: createResultFile: createFiles: op(c): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 2 19:18:13.736904 ignition[1253]: INFO : files: files passed Oct 2 19:18:13.736904 ignition[1253]: INFO : Ignition finished successfully Oct 2 19:18:13.695691 systemd[1]: Finished ignition-files.service. Oct 2 19:18:13.716686 systemd[1]: Starting initrd-setup-root-after-ignition.service... Oct 2 19:18:13.751890 initrd-setup-root-after-ignition[1268]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 2 19:18:13.765419 kernel: audit: type=1130 audit(1696274293.750:38): 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 19:18:13.765454 kernel: audit: type=1130 audit(1696274293.753:39): 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 19:18:13.765474 kernel: audit: type=1131 audit(1696274293.753:40): 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 19:18:13.750000 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 19:18:13.753000 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 19:18:13.753000 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 19:18:13.730457 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Oct 2 19:18:13.736654 systemd[1]: Starting ignition-quench.service... Oct 2 19:18:13.749320 systemd[1]: Finished initrd-setup-root-after-ignition.service. Oct 2 19:18:13.750913 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 2 19:18:13.751027 systemd[1]: Finished ignition-quench.service. Oct 2 19:18:13.753371 systemd[1]: Reached target ignition-complete.target. Oct 2 19:18:13.775589 systemd[1]: Starting initrd-parse-etc.service... Oct 2 19:18:13.800300 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 2 19:18:13.800428 systemd[1]: Finished initrd-parse-etc.service. Oct 2 19:18:13.803874 systemd[1]: Reached target initrd-fs.target. Oct 2 19:18:13.811100 kernel: audit: type=1130 audit(1696274293.803:41): 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 19:18:13.803000 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 19:18:13.803000 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 19:18:13.811096 systemd[1]: Reached target initrd.target. Oct 2 19:18:13.813273 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Oct 2 19:18:13.816457 systemd[1]: Starting dracut-pre-pivot.service... Oct 2 19:18:13.829957 systemd[1]: Finished dracut-pre-pivot.service. Oct 2 19:18:13.832000 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 19:18:13.834219 systemd[1]: Starting initrd-cleanup.service... Oct 2 19:18:13.866932 systemd[1]: Stopped target nss-lookup.target. Oct 2 19:18:13.867771 systemd[1]: Stopped target remote-cryptsetup.target. Oct 2 19:18:13.872641 systemd[1]: Stopped target timers.target. Oct 2 19:18:13.874908 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 2 19:18:13.876100 systemd[1]: Stopped dracut-pre-pivot.service. Oct 2 19:18:13.878039 systemd[1]: Stopped target initrd.target. Oct 2 19:18:13.876000 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 19:18:13.881613 systemd[1]: Stopped target basic.target. Oct 2 19:18:13.884612 systemd[1]: Stopped target ignition-complete.target. Oct 2 19:18:13.887318 systemd[1]: Stopped target ignition-diskful.target. Oct 2 19:18:13.890039 systemd[1]: Stopped target initrd-root-device.target. Oct 2 19:18:13.892214 systemd[1]: Stopped target remote-fs.target. Oct 2 19:18:13.894593 systemd[1]: Stopped target remote-fs-pre.target. Oct 2 19:18:13.897321 systemd[1]: Stopped target sysinit.target. Oct 2 19:18:13.899889 systemd[1]: Stopped target local-fs.target. Oct 2 19:18:13.902494 systemd[1]: Stopped target local-fs-pre.target. Oct 2 19:18:13.904850 systemd[1]: Stopped target swap.target. Oct 2 19:18:13.906734 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 2 19:18:13.908716 systemd[1]: Stopped dracut-pre-mount.service. Oct 2 19:18:13.912000 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 19:18:13.912495 systemd[1]: Stopped target cryptsetup.target. Oct 2 19:18:13.915242 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 2 19:18:13.916653 systemd[1]: Stopped dracut-initqueue.service. Oct 2 19:18:13.919000 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 19:18:13.919297 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 2 19:18:13.922000 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 19:18:13.919408 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Oct 2 19:18:13.922697 systemd[1]: ignition-files.service: Deactivated successfully. Oct 2 19:18:13.925573 systemd[1]: Stopped ignition-files.service. Oct 2 19:18:13.926000 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 19:18:13.932655 systemd[1]: Stopping ignition-mount.service... Oct 2 19:18:13.936633 systemd[1]: Stopping iscsid.service... Oct 2 19:18:13.939100 iscsid[1103]: iscsid shutting down. Oct 2 19:18:13.953914 systemd[1]: Stopping sysroot-boot.service... Oct 2 19:18:13.955104 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 2 19:18:13.958566 systemd[1]: Stopped systemd-udev-trigger.service. Oct 2 19:18:13.961000 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 19:18:13.961925 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 2 19:18:13.964469 ignition[1283]: INFO : Ignition 2.14.0 Oct 2 19:18:13.964469 ignition[1283]: INFO : Stage: umount Oct 2 19:18:13.964469 ignition[1283]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Oct 2 19:18:13.964469 ignition[1283]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Oct 2 19:18:13.966788 systemd[1]: Stopped dracut-pre-trigger.service. Oct 2 19:18:13.977000 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 19:18:13.980796 systemd[1]: iscsid.service: Deactivated successfully. Oct 2 19:18:13.981171 systemd[1]: Stopped iscsid.service. Oct 2 19:18:13.985000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 19:18:13.987808 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 2 19:18:13.989502 systemd[1]: Finished initrd-cleanup.service. Oct 2 19:18:13.991000 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 19:18:13.991000 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 19:18:13.993986 ignition[1283]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Oct 2 19:18:13.995648 ignition[1283]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Oct 2 19:18:13.995178 systemd[1]: Stopping iscsiuio.service... Oct 2 19:18:13.999369 systemd[1]: iscsiuio.service: Deactivated successfully. Oct 2 19:18:13.999685 systemd[1]: Stopped iscsiuio.service. Oct 2 19:18:14.002000 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 19:18:14.003344 ignition[1283]: INFO : PUT result: OK Oct 2 19:18:14.006563 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 2 19:18:14.006000 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 19:18:14.008841 ignition[1283]: INFO : umount: umount passed Oct 2 19:18:14.008841 ignition[1283]: INFO : Ignition finished successfully Oct 2 19:18:14.006683 systemd[1]: Stopped sysroot-boot.service. Oct 2 19:18:14.012901 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 2 19:18:14.014000 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 19:18:14.015000 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 19:18:14.012996 systemd[1]: Stopped ignition-mount.service. Oct 2 19:18:14.014553 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 2 19:18:14.014608 systemd[1]: Stopped ignition-disks.service. Oct 2 19:18:14.021000 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 19:18:14.016075 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 2 19:18:14.016138 systemd[1]: Stopped ignition-kargs.service. Oct 2 19:18:14.024000 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 19:18:14.022248 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 2 19:18:14.022321 systemd[1]: Stopped ignition-fetch.service. Oct 2 19:18:14.025430 systemd[1]: Stopped target network.target. Oct 2 19:18:14.029000 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 19:18:14.026470 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 2 19:18:14.027547 systemd[1]: Stopped ignition-fetch-offline.service. Oct 2 19:18:14.029999 systemd[1]: Stopped target paths.target. Oct 2 19:18:14.031988 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 2 19:18:14.036180 systemd[1]: Stopped systemd-ask-password-console.path. Oct 2 19:18:14.038542 systemd[1]: Stopped target slices.target. Oct 2 19:18:14.041616 systemd[1]: Stopped target sockets.target. Oct 2 19:18:14.043458 systemd[1]: iscsid.socket: Deactivated successfully. Oct 2 19:18:14.050000 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 19:18:14.043505 systemd[1]: Closed iscsid.socket. Oct 2 19:18:14.052000 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 19:18:14.043665 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 2 19:18:14.043854 systemd[1]: Closed iscsiuio.socket. Oct 2 19:18:14.047819 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 2 19:18:14.047883 systemd[1]: Stopped ignition-setup.service. Oct 2 19:18:14.051014 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 2 19:18:14.051076 systemd[1]: Stopped initrd-setup-root.service. Oct 2 19:18:14.067000 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 19:18:14.052755 systemd[1]: Stopping systemd-networkd.service... Oct 2 19:18:14.052920 systemd[1]: Stopping systemd-resolved.service... Oct 2 19:18:14.062622 systemd-networkd[1098]: eth0: DHCPv6 lease lost Oct 2 19:18:14.071000 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 19:18:14.064247 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 2 19:18:14.072000 audit: BPF prog-id=6 op=UNLOAD Oct 2 19:18:14.064380 systemd[1]: Stopped systemd-resolved.service. Oct 2 19:18:14.075000 audit: BPF prog-id=9 op=UNLOAD Oct 2 19:18:14.069565 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 2 19:18:14.069699 systemd[1]: Stopped systemd-networkd.service. Oct 2 19:18:14.072984 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 2 19:18:14.073064 systemd[1]: Closed systemd-networkd.socket. Oct 2 19:18:14.082192 systemd[1]: Stopping network-cleanup.service... Oct 2 19:18:14.085000 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 19:18:14.083318 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 2 19:18:14.088000 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 19:18:14.083400 systemd[1]: Stopped parse-ip-for-networkd.service. Oct 2 19:18:14.090000 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 19:18:14.085810 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 2 19:18:14.086080 systemd[1]: Stopped systemd-sysctl.service. Oct 2 19:18:14.088539 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 2 19:18:14.088600 systemd[1]: Stopped systemd-modules-load.service. Oct 2 19:18:14.091009 systemd[1]: Stopping systemd-udevd.service... Oct 2 19:18:14.105000 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 19:18:14.107000 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 19:18:14.102836 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 2 19:18:14.104083 systemd[1]: Stopped network-cleanup.service. Oct 2 19:18:14.105794 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 2 19:18:14.106143 systemd[1]: Stopped systemd-udevd.service. Oct 2 19:18:14.118000 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 19:18:14.108113 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 2 19:18:14.108168 systemd[1]: Closed systemd-udevd-control.socket. Oct 2 19:18:14.110390 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 2 19:18:14.125000 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 19:18:14.110442 systemd[1]: Closed systemd-udevd-kernel.socket. Oct 2 19:18:14.112246 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 2 19:18:14.129000 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 19:18:14.112307 systemd[1]: Stopped dracut-pre-udev.service. Oct 2 19:18:14.119128 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 2 19:18:14.122513 systemd[1]: Stopped dracut-cmdline.service. Oct 2 19:18:14.127025 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 2 19:18:14.127110 systemd[1]: Stopped dracut-cmdline-ask.service. Oct 2 19:18:14.137017 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Oct 2 19:18:14.140000 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 19:18:14.138524 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 2 19:18:14.138619 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service. Oct 2 19:18:14.141654 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 2 19:18:14.141721 systemd[1]: Stopped kmod-static-nodes.service. Oct 2 19:18:14.148000 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 19:18:14.148986 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 2 19:18:14.152000 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 19:18:14.155000 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 19:18:14.155000 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 19:18:14.149141 systemd[1]: Stopped systemd-vconsole-setup.service. Oct 2 19:18:14.153493 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 2 19:18:14.153765 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Oct 2 19:18:14.156108 systemd[1]: Reached target initrd-switch-root.target. Oct 2 19:18:14.160026 systemd[1]: Starting initrd-switch-root.service... Oct 2 19:18:14.179132 systemd[1]: Switching root. Oct 2 19:18:14.204378 systemd-journald[185]: Journal stopped Oct 2 19:18:19.112900 systemd-journald[185]: Received SIGTERM from PID 1 (systemd). Oct 2 19:18:19.113067 kernel: SELinux: Class mctp_socket not defined in policy. Oct 2 19:18:19.113154 kernel: SELinux: Class anon_inode not defined in policy. Oct 2 19:18:19.113181 kernel: SELinux: the above unknown classes and permissions will be allowed Oct 2 19:18:19.113236 kernel: SELinux: policy capability network_peer_controls=1 Oct 2 19:18:19.113255 kernel: SELinux: policy capability open_perms=1 Oct 2 19:18:19.113273 kernel: SELinux: policy capability extended_socket_class=1 Oct 2 19:18:19.113333 kernel: SELinux: policy capability always_check_network=0 Oct 2 19:18:19.113353 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 2 19:18:19.113424 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 2 19:18:19.113444 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 2 19:18:19.113501 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 2 19:18:19.113525 systemd[1]: Successfully loaded SELinux policy in 97.878ms. Oct 2 19:18:19.113692 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 11.048ms. Oct 2 19:18:19.113717 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 19:18:19.113770 systemd[1]: Detected virtualization amazon. Oct 2 19:18:19.113792 systemd[1]: Detected architecture x86-64. Oct 2 19:18:19.113811 systemd[1]: Detected first boot. Oct 2 19:18:19.113865 systemd[1]: Initializing machine ID from VM UUID. Oct 2 19:18:19.113887 systemd[1]: Populated /etc with preset unit settings. Oct 2 19:18:19.113938 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 19:18:19.113965 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 19:18:19.114016 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 19:18:19.114044 kernel: kauditd_printk_skb: 45 callbacks suppressed Oct 2 19:18:19.114064 kernel: audit: type=1334 audit(1696274298.748:87): prog-id=12 op=LOAD Oct 2 19:18:19.114219 kernel: audit: type=1334 audit(1696274298.748:88): prog-id=3 op=UNLOAD Oct 2 19:18:19.114245 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 2 19:18:19.114264 kernel: audit: type=1334 audit(1696274298.749:89): prog-id=13 op=LOAD Oct 2 19:18:19.114281 kernel: audit: type=1334 audit(1696274298.751:90): prog-id=14 op=LOAD Oct 2 19:18:19.114298 kernel: audit: type=1334 audit(1696274298.751:91): prog-id=4 op=UNLOAD Oct 2 19:18:19.114321 systemd[1]: Stopped initrd-switch-root.service. Oct 2 19:18:19.114339 kernel: audit: type=1334 audit(1696274298.751:92): prog-id=5 op=UNLOAD Oct 2 19:18:19.114357 kernel: audit: type=1131 audit(1696274298.752:93): 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 19:18:19.114374 kernel: audit: type=1334 audit(1696274298.765:94): prog-id=12 op=UNLOAD Oct 2 19:18:19.114396 kernel: audit: type=1130 audit(1696274298.768:95): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 19:18:19.114419 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 2 19:18:19.114438 kernel: audit: type=1131 audit(1696274298.768:96): 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 19:18:19.114456 systemd[1]: Created slice system-addon\x2dconfig.slice. Oct 2 19:18:19.114475 systemd[1]: Created slice system-addon\x2drun.slice. Oct 2 19:18:19.114553 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice. Oct 2 19:18:19.114573 systemd[1]: Created slice system-getty.slice. Oct 2 19:18:19.114595 systemd[1]: Created slice system-modprobe.slice. Oct 2 19:18:19.114615 systemd[1]: Created slice system-serial\x2dgetty.slice. Oct 2 19:18:19.114635 systemd[1]: Created slice system-system\x2dcloudinit.slice. Oct 2 19:18:19.114655 systemd[1]: Created slice system-systemd\x2dfsck.slice. Oct 2 19:18:19.114674 systemd[1]: Created slice user.slice. Oct 2 19:18:19.114693 systemd[1]: Started systemd-ask-password-console.path. Oct 2 19:18:19.114711 systemd[1]: Started systemd-ask-password-wall.path. Oct 2 19:18:19.114779 systemd[1]: Set up automount boot.automount. Oct 2 19:18:19.114799 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Oct 2 19:18:19.114821 systemd[1]: Stopped target initrd-switch-root.target. Oct 2 19:18:19.114840 systemd[1]: Stopped target initrd-fs.target. Oct 2 19:18:19.114859 systemd[1]: Stopped target initrd-root-fs.target. Oct 2 19:18:19.114879 systemd[1]: Reached target integritysetup.target. Oct 2 19:18:19.114897 systemd[1]: Reached target remote-cryptsetup.target. Oct 2 19:18:19.114916 systemd[1]: Reached target remote-fs.target. Oct 2 19:18:19.114935 systemd[1]: Reached target slices.target. Oct 2 19:18:19.114954 systemd[1]: Reached target swap.target. Oct 2 19:18:19.114972 systemd[1]: Reached target torcx.target. Oct 2 19:18:19.114993 systemd[1]: Reached target veritysetup.target. Oct 2 19:18:19.115010 systemd[1]: Listening on systemd-coredump.socket. Oct 2 19:18:19.115030 systemd[1]: Listening on systemd-initctl.socket. Oct 2 19:18:19.115048 systemd[1]: Listening on systemd-networkd.socket. Oct 2 19:18:19.115066 systemd[1]: Listening on systemd-udevd-control.socket. Oct 2 19:18:19.115095 systemd[1]: Listening on systemd-udevd-kernel.socket. Oct 2 19:18:19.115115 systemd[1]: Listening on systemd-userdbd.socket. Oct 2 19:18:19.115133 systemd[1]: Mounting dev-hugepages.mount... Oct 2 19:18:19.115151 systemd[1]: Mounting dev-mqueue.mount... Oct 2 19:18:19.115169 systemd[1]: Mounting media.mount... Oct 2 19:18:19.115192 systemd[1]: proc-xen.mount was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 2 19:18:19.115262 systemd[1]: Mounting sys-kernel-debug.mount... Oct 2 19:18:19.115284 systemd[1]: Mounting sys-kernel-tracing.mount... Oct 2 19:18:19.115304 systemd[1]: Mounting tmp.mount... Oct 2 19:18:19.115322 systemd[1]: Starting flatcar-tmpfiles.service... Oct 2 19:18:19.115342 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Oct 2 19:18:19.115360 systemd[1]: Starting kmod-static-nodes.service... Oct 2 19:18:19.115378 systemd[1]: Starting modprobe@configfs.service... Oct 2 19:18:19.115397 systemd[1]: Starting modprobe@dm_mod.service... Oct 2 19:18:19.115420 systemd[1]: Starting modprobe@drm.service... Oct 2 19:18:19.115438 systemd[1]: Starting modprobe@efi_pstore.service... Oct 2 19:18:19.115456 systemd[1]: Starting modprobe@fuse.service... Oct 2 19:18:19.115474 systemd[1]: Starting modprobe@loop.service... Oct 2 19:18:19.115493 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 2 19:18:19.115511 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 2 19:18:19.115529 systemd[1]: Stopped systemd-fsck-root.service. Oct 2 19:18:19.115548 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 2 19:18:19.115567 systemd[1]: Stopped systemd-fsck-usr.service. Oct 2 19:18:19.115685 systemd[1]: Stopped systemd-journald.service. Oct 2 19:18:19.115714 systemd[1]: Starting systemd-journald.service... Oct 2 19:18:19.115732 systemd[1]: Starting systemd-modules-load.service... Oct 2 19:18:19.115750 systemd[1]: Starting systemd-network-generator.service... Oct 2 19:18:19.115768 systemd[1]: Starting systemd-remount-fs.service... Oct 2 19:18:19.115787 systemd[1]: Starting systemd-udev-trigger.service... Oct 2 19:18:19.115806 systemd[1]: verity-setup.service: Deactivated successfully. Oct 2 19:18:19.115824 systemd[1]: Stopped verity-setup.service. Oct 2 19:18:19.115843 systemd[1]: xenserver-pv-version.service was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 2 19:18:19.115864 systemd[1]: Mounted dev-hugepages.mount. Oct 2 19:18:19.115882 systemd[1]: Mounted dev-mqueue.mount. Oct 2 19:18:19.115900 systemd[1]: Mounted media.mount. Oct 2 19:18:19.115919 systemd[1]: Mounted sys-kernel-debug.mount. Oct 2 19:18:19.115936 systemd[1]: Mounted sys-kernel-tracing.mount. Oct 2 19:18:19.115954 systemd[1]: Mounted tmp.mount. Oct 2 19:18:19.115972 systemd[1]: Finished kmod-static-nodes.service. Oct 2 19:18:19.115991 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 2 19:18:19.116009 systemd[1]: Finished modprobe@configfs.service. Oct 2 19:18:19.116029 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 2 19:18:19.116047 systemd[1]: Finished modprobe@dm_mod.service. Oct 2 19:18:19.116065 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 2 19:18:19.116095 systemd[1]: Finished modprobe@drm.service. Oct 2 19:18:19.116115 kernel: fuse: init (API version 7.34) Oct 2 19:18:19.116134 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 2 19:18:19.116155 systemd[1]: Finished modprobe@efi_pstore.service. Oct 2 19:18:19.116176 kernel: loop: module loaded Oct 2 19:18:19.116194 systemd[1]: Finished systemd-modules-load.service. Oct 2 19:18:19.122948 systemd[1]: Finished systemd-network-generator.service. Oct 2 19:18:19.122991 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 2 19:18:19.123013 systemd[1]: Finished modprobe@fuse.service. Oct 2 19:18:19.123035 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 2 19:18:19.123057 systemd[1]: Finished modprobe@loop.service. Oct 2 19:18:19.123099 systemd[1]: Finished systemd-remount-fs.service. Oct 2 19:18:19.123131 systemd[1]: Reached target network-pre.target. Oct 2 19:18:19.123156 systemd[1]: Mounting sys-fs-fuse-connections.mount... Oct 2 19:18:19.123184 systemd-journald[1390]: Journal started Oct 2 19:18:19.123268 systemd-journald[1390]: Runtime Journal (/run/log/journal/ec25189e55c6b9ad04df8098a5ba0633) is 4.8M, max 38.7M, 33.9M free. Oct 2 19:18:14.678000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 2 19:18:14.807000 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 19:18:14.807000 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 19:18:14.807000 audit: BPF prog-id=10 op=LOAD Oct 2 19:18:14.807000 audit: BPF prog-id=10 op=UNLOAD Oct 2 19:18:14.807000 audit: BPF prog-id=11 op=LOAD Oct 2 19:18:14.807000 audit: BPF prog-id=11 op=UNLOAD Oct 2 19:18:18.748000 audit: BPF prog-id=12 op=LOAD Oct 2 19:18:18.748000 audit: BPF prog-id=3 op=UNLOAD Oct 2 19:18:18.749000 audit: BPF prog-id=13 op=LOAD Oct 2 19:18:18.751000 audit: BPF prog-id=14 op=LOAD Oct 2 19:18:18.751000 audit: BPF prog-id=4 op=UNLOAD Oct 2 19:18:18.751000 audit: BPF prog-id=5 op=UNLOAD Oct 2 19:18:18.752000 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 19:18:18.765000 audit: BPF prog-id=12 op=UNLOAD Oct 2 19:18:18.768000 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 19:18:18.768000 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 19:18:18.967000 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 19:18:18.975000 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 19:18:18.978000 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 19:18:18.978000 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 19:18:18.981000 audit: BPF prog-id=15 op=LOAD Oct 2 19:18:18.981000 audit: BPF prog-id=16 op=LOAD Oct 2 19:18:18.981000 audit: BPF prog-id=17 op=LOAD Oct 2 19:18:18.981000 audit: BPF prog-id=13 op=UNLOAD Oct 2 19:18:18.981000 audit: BPF prog-id=14 op=UNLOAD Oct 2 19:18:19.013000 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 19:18:19.047000 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 19:18:19.053000 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 19:18:19.053000 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 19:18:19.062000 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 19:18:19.062000 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 19:18:19.071000 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 19:18:19.071000 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 19:18:19.078000 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 19:18:19.078000 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 19:18:19.082000 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 19:18:19.090000 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 19:18:19.100000 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 19:18:19.100000 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 19:18:19.109000 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 19:18:19.109000 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 19:18:19.110000 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 19:18:19.110000 audit[1390]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=4 a1=7ffc6b4f0b00 a2=4000 a3=7ffc6b4f0b9c items=0 ppid=1 pid=1390 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 19:18:19.110000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 2 19:18:19.112000 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 19:18:15.023724 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" 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 19:18:18.746192 systemd[1]: Queued start job for default target multi-user.target. Oct 2 19:18:15.024598 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 2 19:18:18.751887 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 2 19:18:15.024635 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 2 19:18:15.024762 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Oct 2 19:18:19.126181 systemd[1]: Mounting sys-kernel-config.mount... Oct 2 19:18:15.024780 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" level=debug msg="skipped missing lower profile" missing profile=oem Oct 2 19:18:15.024825 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Oct 2 19:18:15.024846 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Oct 2 19:18:15.025138 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Oct 2 19:18:15.025193 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Oct 2 19:18:15.025213 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Oct 2 19:18:15.026069 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" 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 19:18:15.026142 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" 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 19:18:15.026172 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" 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 19:18:15.026196 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" 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 19:18:15.026222 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" 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 19:18:15.026244 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:15Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Oct 2 19:18:18.332757 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:18Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Oct 2 19:18:18.333026 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:18Z" 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 19:18:18.333184 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:18Z" 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 19:18:18.333370 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:18Z" 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 19:18:19.138241 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 2 19:18:18.333421 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:18Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Oct 2 19:18:18.333479 /usr/lib/systemd/system-generators/torcx-generator[1316]: time="2023-10-02T19:18:18Z" 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 19:18:19.147207 systemd[1]: Starting systemd-hwdb-update.service... Oct 2 19:18:19.147285 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 2 19:18:19.154637 systemd[1]: Starting systemd-random-seed.service... Oct 2 19:18:19.154712 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Oct 2 19:18:19.156648 systemd[1]: Starting systemd-sysctl.service... Oct 2 19:18:19.167113 systemd[1]: Started systemd-journald.service. Oct 2 19:18:19.164000 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 19:18:19.165842 systemd[1]: Mounted sys-fs-fuse-connections.mount. Oct 2 19:18:19.167302 systemd[1]: Mounted sys-kernel-config.mount. Oct 2 19:18:19.168897 systemd[1]: Finished systemd-random-seed.service. Oct 2 19:18:19.170000 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 19:18:19.170802 systemd[1]: Reached target first-boot-complete.target. Oct 2 19:18:19.174223 systemd[1]: Starting systemd-journal-flush.service... Oct 2 19:18:19.191280 systemd-journald[1390]: Time spent on flushing to /var/log/journal/ec25189e55c6b9ad04df8098a5ba0633 is 86.886ms for 1143 entries. Oct 2 19:18:19.191280 systemd-journald[1390]: System Journal (/var/log/journal/ec25189e55c6b9ad04df8098a5ba0633) is 8.0M, max 195.6M, 187.6M free. Oct 2 19:18:19.287518 systemd-journald[1390]: Received client request to flush runtime journal. Oct 2 19:18:19.218000 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 19:18:19.235000 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 19:18:19.290000 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 19:18:19.216929 systemd[1]: Finished systemd-sysctl.service. Oct 2 19:18:19.233595 systemd[1]: Finished systemd-udev-trigger.service. Oct 2 19:18:19.291292 udevadm[1425]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 2 19:18:19.237277 systemd[1]: Starting systemd-udev-settle.service... Oct 2 19:18:19.288945 systemd[1]: Finished systemd-journal-flush.service. Oct 2 19:18:19.295000 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 19:18:19.294240 systemd[1]: Finished flatcar-tmpfiles.service. Oct 2 19:18:19.297163 systemd[1]: Starting systemd-sysusers.service... Oct 2 19:18:19.333146 systemd[1]: Finished systemd-sysusers.service. Oct 2 19:18:19.334000 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 19:18:19.336105 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Oct 2 19:18:19.381308 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Oct 2 19:18:19.382000 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 19:18:20.026056 systemd[1]: Finished systemd-hwdb-update.service. Oct 2 19:18:20.027000 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 19:18:20.028000 audit: BPF prog-id=18 op=LOAD Oct 2 19:18:20.028000 audit: BPF prog-id=19 op=LOAD Oct 2 19:18:20.028000 audit: BPF prog-id=7 op=UNLOAD Oct 2 19:18:20.028000 audit: BPF prog-id=8 op=UNLOAD Oct 2 19:18:20.029343 systemd[1]: Starting systemd-udevd.service... Oct 2 19:18:20.071459 systemd-udevd[1435]: Using default interface naming scheme 'v252'. Oct 2 19:18:20.104270 systemd[1]: Started systemd-udevd.service. Oct 2 19:18:20.105000 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 19:18:20.106000 audit: BPF prog-id=20 op=LOAD Oct 2 19:18:20.107987 systemd[1]: Starting systemd-networkd.service... Oct 2 19:18:20.119000 audit: BPF prog-id=21 op=LOAD Oct 2 19:18:20.119000 audit: BPF prog-id=22 op=LOAD Oct 2 19:18:20.119000 audit: BPF prog-id=23 op=LOAD Oct 2 19:18:20.120354 systemd[1]: Starting systemd-userdbd.service... Oct 2 19:18:20.203185 systemd[1]: Started systemd-userdbd.service. Oct 2 19:18:20.204000 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 19:18:20.221000 (udev-worker)[1445]: Network interface NamePolicy= disabled on kernel command line. Oct 2 19:18:20.222725 systemd[1]: Condition check resulted in dev-ttyS0.device being skipped. Oct 2 19:18:20.301827 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Oct 2 19:18:20.318114 kernel: ACPI: button: Power Button [PWRF] Oct 2 19:18:20.318265 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input3 Oct 2 19:18:20.341382 systemd-networkd[1444]: lo: Link UP Oct 2 19:18:20.341394 systemd-networkd[1444]: lo: Gained carrier Oct 2 19:18:20.341939 systemd-networkd[1444]: Enumeration completed Oct 2 19:18:20.342047 systemd[1]: Started systemd-networkd.service. Oct 2 19:18:20.342318 systemd-networkd[1444]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 2 19:18:20.345395 systemd[1]: Starting systemd-networkd-wait-online.service... Oct 2 19:18:20.343000 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 19:18:20.356172 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Oct 2 19:18:20.355678 systemd-networkd[1444]: eth0: Link UP Oct 2 19:18:20.355896 systemd-networkd[1444]: eth0: Gained carrier Oct 2 19:18:20.366148 kernel: ACPI: button: Sleep Button [SLPF] Oct 2 19:18:20.366337 systemd-networkd[1444]: eth0: DHCPv4 address 172.31.16.170/20, gateway 172.31.16.1 acquired from 172.31.16.1 Oct 2 19:18:20.352000 audit[1439]: AVC avc: denied { confidentiality } for pid=1439 comm="(udev-worker)" lockdown_reason="use of tracefs" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=lockdown permissive=1 Oct 2 19:18:20.352000 audit[1439]: SYSCALL arch=c000003e syscall=175 success=yes exit=0 a0=564bd9d4a8b0 a1=32194 a2=7f2671463bc5 a3=5 items=106 ppid=1435 pid=1439 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="(udev-worker)" exe="/usr/bin/udevadm" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 2 19:18:20.352000 audit: CWD cwd="/" Oct 2 19:18:20.352000 audit: PATH item=0 name=(null) inode=14651 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=1 name=(null) inode=14652 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=2 name=(null) inode=14651 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=3 name=(null) inode=14653 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=4 name=(null) inode=14651 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=5 name=(null) inode=14654 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=6 name=(null) inode=14654 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=7 name=(null) inode=14655 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=8 name=(null) inode=14654 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=9 name=(null) inode=14656 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=10 name=(null) inode=14654 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=11 name=(null) inode=14657 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=12 name=(null) inode=14654 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=13 name=(null) inode=14658 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=14 name=(null) inode=14654 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=15 name=(null) inode=14659 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=16 name=(null) inode=14651 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=17 name=(null) inode=14660 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=18 name=(null) inode=14660 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=19 name=(null) inode=14661 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=20 name=(null) inode=14660 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=21 name=(null) inode=14662 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=22 name=(null) inode=14660 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=23 name=(null) inode=14663 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=24 name=(null) inode=14660 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=25 name=(null) inode=14664 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=26 name=(null) inode=14660 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=27 name=(null) inode=14665 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=28 name=(null) inode=14651 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=29 name=(null) inode=14666 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=30 name=(null) inode=14666 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=31 name=(null) inode=14667 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=32 name=(null) inode=14666 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=33 name=(null) inode=14668 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=34 name=(null) inode=14666 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=35 name=(null) inode=14669 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=36 name=(null) inode=14666 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=37 name=(null) inode=14670 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=38 name=(null) inode=14666 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=39 name=(null) inode=14671 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=40 name=(null) inode=14651 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=41 name=(null) inode=14672 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=42 name=(null) inode=14672 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=43 name=(null) inode=14673 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=44 name=(null) inode=14672 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=45 name=(null) inode=14674 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=46 name=(null) inode=14672 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=47 name=(null) inode=14675 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=48 name=(null) inode=14672 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=49 name=(null) inode=14676 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=50 name=(null) inode=14672 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=51 name=(null) inode=14677 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=52 name=(null) inode=40 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=53 name=(null) inode=14678 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=54 name=(null) inode=14678 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=55 name=(null) inode=14679 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=56 name=(null) inode=14678 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=57 name=(null) inode=14680 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=58 name=(null) inode=14678 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=59 name=(null) inode=14681 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=60 name=(null) inode=14681 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=61 name=(null) inode=14682 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=62 name=(null) inode=14681 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=63 name=(null) inode=14683 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=64 name=(null) inode=14681 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=65 name=(null) inode=14684 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=66 name=(null) inode=14681 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=67 name=(null) inode=14685 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=68 name=(null) inode=14681 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=69 name=(null) inode=14686 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=70 name=(null) inode=14678 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=71 name=(null) inode=14687 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=72 name=(null) inode=14687 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=73 name=(null) inode=14688 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=74 name=(null) inode=14687 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=75 name=(null) inode=14689 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=76 name=(null) inode=14687 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=77 name=(null) inode=14690 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=78 name=(null) inode=14687 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=79 name=(null) inode=14691 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=80 name=(null) inode=14687 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=81 name=(null) inode=14692 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=82 name=(null) inode=14678 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=83 name=(null) inode=14693 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=84 name=(null) inode=14693 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=85 name=(null) inode=14694 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=86 name=(null) inode=14693 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=87 name=(null) inode=14695 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=88 name=(null) inode=14693 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=89 name=(null) inode=14696 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=90 name=(null) inode=14693 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=91 name=(null) inode=14697 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=92 name=(null) inode=14693 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=93 name=(null) inode=14698 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=94 name=(null) inode=14678 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=95 name=(null) inode=14699 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=96 name=(null) inode=14699 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=97 name=(null) inode=14700 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=98 name=(null) inode=14699 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=99 name=(null) inode=14701 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=100 name=(null) inode=14699 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=101 name=(null) inode=14702 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=102 name=(null) inode=14699 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=103 name=(null) inode=14703 dev=00:0b mode=0100640 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=104 name=(null) inode=14699 dev=00:0b mode=040750 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PATH item=105 name=(null) inode=14704 dev=00:0b mode=0100440 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:tracefs_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Oct 2 19:18:20.352000 audit: PROCTITLE proctitle="(udev-worker)" Oct 2 19:18:20.385291 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0xb100, revision 255 Oct 2 19:18:20.410205 kernel: input: ImPS/2 Generic Wheel Mouse as /devices/platform/i8042/serio1/input/input4 Oct 2 19:18:20.438114 kernel: BTRFS info: devid 1 device path /dev/disk/by-label/OEM changed to /dev/nvme0n1p6 scanned by (udev-worker) (1452) Oct 2 19:18:20.464159 kernel: mousedev: PS/2 mouse device common for all mice Oct 2 19:18:20.576621 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Oct 2 19:18:20.693562 systemd[1]: Finished systemd-udev-settle.service. Oct 2 19:18:20.694000 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 19:18:20.696212 systemd[1]: Starting lvm2-activation-early.service... Oct 2 19:18:20.724425 lvm[1549]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 2 19:18:20.750304 systemd[1]: Finished lvm2-activation-early.service. Oct 2 19:18:20.751000 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 19:18:20.751723 systemd[1]: Reached target cryptsetup.target. Oct 2 19:18:20.754444 systemd[1]: Starting lvm2-activation.service... Oct 2 19:18:20.759324 lvm[1550]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 2 19:18:20.788914 systemd[1]: Finished lvm2-activation.service. Oct 2 19:18:20.790000 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 19:18:20.790257 systemd[1]: Reached target local-fs-pre.target. Oct 2 19:18:20.791813 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Oct 2 19:18:20.791926 systemd[1]: Reached target local-fs.target. Oct 2 19:18:20.793375 systemd[1]: Reached target machines.target. Oct 2 19:18:20.795979 systemd[1]: Starting ldconfig.service... Oct 2 19:18:20.797615 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Oct 2 19:18:20.797696 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 19:18:20.798970 systemd[1]: Starting systemd-boot-update.service... Oct 2 19:18:20.801289 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Oct 2 19:18:20.804226 systemd[1]: Starting systemd-machine-id-commit.service... Oct 2 19:18:20.805557 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Oct 2 19:18:20.805649 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Oct 2 19:18:20.807326 systemd[1]: Starting systemd-tmpfiles-setup.service... Oct 2 19:18:20.824791 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1552 (bootctl) Oct 2 19:18:20.826803 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Oct 2 19:18:20.850196 systemd-tmpfiles[1555]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Oct 2 19:18:20.858374 systemd-tmpfiles[1555]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 2 19:18:20.864904 systemd-tmpfiles[1555]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 2 19:18:20.878325 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Oct 2 19:18:20.880000 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 19:18:20.904690 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 2 19:18:20.906000 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 19:18:20.905713 systemd[1]: Finished systemd-machine-id-commit.service. Oct 2 19:18:20.957626 systemd-fsck[1560]: fsck.fat 4.2 (2021-01-31) Oct 2 19:18:20.957626 systemd-fsck[1560]: /dev/nvme0n1p1: 789 files, 115069/258078 clusters Oct 2 19:18:20.961337 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Oct 2 19:18:20.962000 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 19:18:20.964635 systemd[1]: Mounting boot.mount... Oct 2 19:18:20.984951 systemd[1]: Mounted boot.mount. Oct 2 19:18:21.032000 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 19:18:21.031214 systemd[1]: Finished systemd-boot-update.service. Oct 2 19:18:21.120031 systemd[1]: Finished systemd-tmpfiles-setup.service. Oct 2 19:18:21.122000 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 19:18:21.123803 systemd[1]: Starting audit-rules.service... Oct 2 19:18:21.132000 audit: BPF prog-id=24 op=LOAD Oct 2 19:18:21.126475 systemd[1]: Starting clean-ca-certificates.service... Oct 2 19:18:21.137000 audit: BPF prog-id=25 op=LOAD Oct 2 19:18:21.129626 systemd[1]: Starting systemd-journal-catalog-update.service... Oct 2 19:18:21.134345 systemd[1]: Starting systemd-resolved.service... Oct 2 19:18:21.149000 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 19:18:21.140996 systemd[1]: Starting systemd-timesyncd.service... Oct 2 19:18:21.144548 systemd[1]: Starting systemd-update-utmp.service... Oct 2 19:18:21.148235 systemd[1]: Finished clean-ca-certificates.service. Oct 2 19:18:21.150196 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Oct 2 19:18:21.180000 audit[1581]: SYSTEM_BOOT pid=1581 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 19:18:21.186657 systemd[1]: Finished systemd-update-utmp.service. Oct 2 19:18:21.187000 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 19:18:21.311000 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 19:18:21.311000 audit[1595]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffd17af2680 a2=420 a3=0 items=0 ppid=1575 pid=1595 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 19:18:21.311000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 2 19:18:21.312192 augenrules[1595]: No rules Oct 2 19:18:21.312851 systemd[1]: Finished audit-rules.service. Oct 2 19:18:21.333035 systemd[1]: Finished systemd-journal-catalog-update.service. Oct 2 19:18:21.364939 systemd[1]: Started systemd-timesyncd.service. Oct 2 19:18:21.371418 systemd[1]: Reached target time-set.target. Oct 2 19:18:21.378402 systemd-resolved[1578]: Positive Trust Anchors: Oct 2 19:18:21.378422 systemd-resolved[1578]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 2 19:18:21.378939 systemd-resolved[1578]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Oct 2 19:18:21.386575 ldconfig[1551]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 2 19:18:21.395572 systemd[1]: Finished ldconfig.service. Oct 2 19:18:21.398220 systemd[1]: Starting systemd-update-done.service... Oct 2 19:18:21.408963 systemd[1]: Finished systemd-update-done.service. Oct 2 19:18:21.411989 systemd-resolved[1578]: Defaulting to hostname 'linux'. Oct 2 19:18:21.413850 systemd[1]: Started systemd-resolved.service. Oct 2 19:18:21.414952 systemd[1]: Reached target network.target. Oct 2 19:18:21.415904 systemd[1]: Reached target nss-lookup.target. Oct 2 19:18:21.417120 systemd[1]: Reached target sysinit.target. Oct 2 19:18:21.418219 systemd[1]: Started motdgen.path. Oct 2 19:18:21.419106 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Oct 2 19:18:21.420550 systemd[1]: Started logrotate.timer. Oct 2 19:18:21.421629 systemd[1]: Started mdadm.timer. Oct 2 19:18:21.422516 systemd[1]: Started systemd-tmpfiles-clean.timer. Oct 2 19:18:21.423638 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 2 19:18:21.423738 systemd[1]: Reached target paths.target. Oct 2 19:18:21.425866 systemd[1]: Reached target timers.target. Oct 2 19:18:21.430672 systemd[1]: Listening on dbus.socket. Oct 2 19:18:21.434261 systemd[1]: Starting docker.socket... Oct 2 19:18:21.439437 systemd[1]: Listening on sshd.socket. Oct 2 19:18:21.440605 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 19:18:21.441245 systemd[1]: Listening on docker.socket. Oct 2 19:18:21.442313 systemd[1]: Reached target sockets.target. Oct 2 19:18:21.443555 systemd[1]: Reached target basic.target. Oct 2 19:18:21.444556 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Oct 2 19:18:21.444581 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Oct 2 19:18:21.445973 systemd[1]: Starting containerd.service... Oct 2 19:18:21.454430 systemd[1]: Starting coreos-metadata-sshkeys@core.service... Oct 2 19:18:21.463507 systemd[1]: Starting dbus.service... Oct 2 19:18:21.470040 systemd[1]: Starting enable-oem-cloudinit.service... Oct 2 19:18:21.475649 systemd[1]: Starting extend-filesystems.service... Oct 2 19:18:21.477805 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Oct 2 19:18:21.479598 systemd[1]: Starting motdgen.service... Oct 2 19:18:21.482134 systemd[1]: Starting ssh-key-proc-cmdline.service... Oct 2 19:18:21.484790 systemd[1]: Starting sshd-keygen.service... Oct 2 19:18:21.489659 systemd[1]: Starting systemd-logind.service... Oct 2 19:18:21.490918 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 19:18:21.490987 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 2 19:18:21.491661 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 2 19:18:21.494663 systemd[1]: Starting update-engine.service... Oct 2 19:18:21.497322 systemd[1]: Starting update-ssh-keys-after-ignition.service... Oct 2 19:18:22.267175 systemd-resolved[1578]: Clock change detected. Flushing caches. Oct 2 19:18:22.267322 systemd-timesyncd[1580]: Contacted time server 71.162.136.44:123 (0.flatcar.pool.ntp.org). Oct 2 19:18:22.267463 systemd-timesyncd[1580]: Initial clock synchronization to Mon 2023-10-02 19:18:22.266769 UTC. Oct 2 19:18:22.287133 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 2 19:18:22.287352 systemd[1]: Finished ssh-key-proc-cmdline.service. Oct 2 19:18:22.309441 jq[1614]: true Oct 2 19:18:22.316081 jq[1607]: false Oct 2 19:18:22.316427 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 2 19:18:22.316655 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Oct 2 19:18:22.325783 jq[1628]: true Oct 2 19:18:22.390184 dbus-daemon[1606]: [system] SELinux support is enabled Oct 2 19:18:22.392522 dbus-daemon[1606]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1444 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Oct 2 19:18:22.390398 systemd[1]: Started dbus.service. Oct 2 19:18:22.419733 extend-filesystems[1608]: Found nvme0n1 Oct 2 19:18:22.419733 extend-filesystems[1608]: Found nvme0n1p1 Oct 2 19:18:22.419733 extend-filesystems[1608]: Found nvme0n1p2 Oct 2 19:18:22.419733 extend-filesystems[1608]: Found nvme0n1p3 Oct 2 19:18:22.419733 extend-filesystems[1608]: Found usr Oct 2 19:18:22.419733 extend-filesystems[1608]: Found nvme0n1p4 Oct 2 19:18:22.419733 extend-filesystems[1608]: Found nvme0n1p6 Oct 2 19:18:22.419733 extend-filesystems[1608]: Found nvme0n1p7 Oct 2 19:18:22.419733 extend-filesystems[1608]: Found nvme0n1p9 Oct 2 19:18:22.419733 extend-filesystems[1608]: Checking size of /dev/nvme0n1p9 Oct 2 19:18:22.396872 dbus-daemon[1606]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 2 19:18:22.394506 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 19:18:22.394541 systemd[1]: Reached target system-config.target. Oct 2 19:18:22.396029 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Oct 2 19:18:22.396080 systemd[1]: Reached target user-config.target. Oct 2 19:18:22.412203 systemd[1]: Starting systemd-hostnamed.service... Oct 2 19:18:22.414880 systemd[1]: motdgen.service: Deactivated successfully. Oct 2 19:18:22.415103 systemd[1]: Finished motdgen.service. Oct 2 19:18:22.449365 extend-filesystems[1608]: Resized partition /dev/nvme0n1p9 Oct 2 19:18:22.456135 extend-filesystems[1651]: resize2fs 1.46.5 (30-Dec-2021) Oct 2 19:18:22.473719 update_engine[1613]: I1002 19:18:22.465294 1613 main.cc:92] Flatcar Update Engine starting Oct 2 19:18:22.474450 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Oct 2 19:18:22.477607 systemd[1]: Started update-engine.service. Oct 2 19:18:22.485632 update_engine[1613]: I1002 19:18:22.477644 1613 update_check_scheduler.cc:74] Next update check in 10m21s Oct 2 19:18:22.483317 systemd[1]: Started locksmithd.service. Oct 2 19:18:22.495256 systemd[1]: Finished update-ssh-keys-after-ignition.service. Oct 2 19:18:22.536627 env[1616]: time="2023-10-02T19:18:22.536559699Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Oct 2 19:18:22.559782 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Oct 2 19:18:22.584134 extend-filesystems[1651]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Oct 2 19:18:22.584134 extend-filesystems[1651]: old_desc_blocks = 1, new_desc_blocks = 1 Oct 2 19:18:22.584134 extend-filesystems[1651]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Oct 2 19:18:22.590411 extend-filesystems[1608]: Resized filesystem in /dev/nvme0n1p9 Oct 2 19:18:22.592771 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 2 19:18:22.593258 systemd[1]: Finished extend-filesystems.service. Oct 2 19:18:22.625322 systemd-logind[1612]: Watching system buttons on /dev/input/event1 (Power Button) Oct 2 19:18:22.625353 systemd-logind[1612]: Watching system buttons on /dev/input/event2 (Sleep Button) Oct 2 19:18:22.625376 systemd-logind[1612]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Oct 2 19:18:22.627513 systemd-logind[1612]: New seat seat0. Oct 2 19:18:22.637175 systemd[1]: Started systemd-logind.service. Oct 2 19:18:22.695963 dbus-daemon[1606]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 2 19:18:22.696169 systemd[1]: Started systemd-hostnamed.service. Oct 2 19:18:22.698893 dbus-daemon[1606]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1645 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Oct 2 19:18:22.702376 systemd[1]: Starting polkit.service... Oct 2 19:18:22.731795 polkitd[1675]: Started polkitd version 121 Oct 2 19:18:22.741664 env[1616]: time="2023-10-02T19:18:22.741301073Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 2 19:18:22.741664 env[1616]: time="2023-10-02T19:18:22.741472830Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 2 19:18:22.754623 polkitd[1675]: Loading rules from directory /etc/polkit-1/rules.d Oct 2 19:18:22.754708 polkitd[1675]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 2 19:18:22.757434 env[1616]: time="2023-10-02T19:18:22.756098930Z" 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 19:18:22.757434 env[1616]: time="2023-10-02T19:18:22.756227407Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 2 19:18:22.757434 env[1616]: time="2023-10-02T19:18:22.756531219Z" 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 19:18:22.757434 env[1616]: time="2023-10-02T19:18:22.756554366Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 2 19:18:22.757434 env[1616]: time="2023-10-02T19:18:22.756574933Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 2 19:18:22.757434 env[1616]: time="2023-10-02T19:18:22.756589484Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 2 19:18:22.757434 env[1616]: time="2023-10-02T19:18:22.756686183Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 2 19:18:22.757434 env[1616]: time="2023-10-02T19:18:22.756945182Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 2 19:18:22.757434 env[1616]: time="2023-10-02T19:18:22.757145656Z" 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 19:18:22.757434 env[1616]: time="2023-10-02T19:18:22.757169851Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 2 19:18:22.757889 env[1616]: time="2023-10-02T19:18:22.757229877Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 2 19:18:22.757889 env[1616]: time="2023-10-02T19:18:22.757245966Z" level=info msg="metadata content store policy set" policy=shared Oct 2 19:18:22.760351 polkitd[1675]: Finished loading, compiling and executing 2 rules Oct 2 19:18:22.762171 dbus-daemon[1606]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 2 19:18:22.762438 systemd[1]: Started polkit.service. Oct 2 19:18:22.764253 polkitd[1675]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768015959Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768084648Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768105663Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768169024Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768192830Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768261938Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768281669Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768302873Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768322152Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768342052Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768361121Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768383185Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768527909Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 2 19:18:22.770577 env[1616]: time="2023-10-02T19:18:22.768633421Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769106724Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769148799Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769170706Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769252112Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769273521Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769354797Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769374332Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769393070Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769411599Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769432672Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769452625Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769473998Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769625804Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769647093Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771188 env[1616]: time="2023-10-02T19:18:22.769666360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771743 env[1616]: time="2023-10-02T19:18:22.769683990Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 2 19:18:22.771743 env[1616]: time="2023-10-02T19:18:22.769710640Z" 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 19:18:22.771743 env[1616]: time="2023-10-02T19:18:22.769727321Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 2 19:18:22.771743 env[1616]: time="2023-10-02T19:18:22.769752197Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Oct 2 19:18:22.771743 env[1616]: time="2023-10-02T19:18:22.769796476Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 2 19:18:22.771938 env[1616]: time="2023-10-02T19:18:22.770093143Z" 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 19:18:22.771938 env[1616]: time="2023-10-02T19:18:22.770176531Z" level=info msg="Connect containerd service" Oct 2 19:18:22.771938 env[1616]: time="2023-10-02T19:18:22.770223037Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 2 19:18:22.776846 env[1616]: time="2023-10-02T19:18:22.772518607Z" 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 19:18:22.776846 env[1616]: time="2023-10-02T19:18:22.772917749Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 2 19:18:22.776846 env[1616]: time="2023-10-02T19:18:22.772970645Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 2 19:18:22.773127 systemd[1]: Started containerd.service. Oct 2 19:18:22.786742 env[1616]: time="2023-10-02T19:18:22.786676185Z" level=info msg="Start subscribing containerd event" Oct 2 19:18:22.788306 systemd-hostnamed[1645]: Hostname set to (transient) Oct 2 19:18:22.791151 systemd-resolved[1578]: System hostname changed to 'ip-172-31-16-170'. Oct 2 19:18:22.800195 env[1616]: time="2023-10-02T19:18:22.800143634Z" level=info msg="Start recovering state" Oct 2 19:18:22.803597 env[1616]: time="2023-10-02T19:18:22.803451950Z" level=info msg="containerd successfully booted in 0.275745s" Oct 2 19:18:22.803812 env[1616]: time="2023-10-02T19:18:22.803794060Z" level=info msg="Start event monitor" Oct 2 19:18:22.803937 env[1616]: time="2023-10-02T19:18:22.803920193Z" level=info msg="Start snapshots syncer" Oct 2 19:18:22.804093 env[1616]: time="2023-10-02T19:18:22.804075957Z" level=info msg="Start cni network conf syncer for default" Oct 2 19:18:22.804236 env[1616]: time="2023-10-02T19:18:22.804222555Z" level=info msg="Start streaming server" Oct 2 19:18:22.814559 systemd[1]: Created slice system-sshd.slice. Oct 2 19:18:22.961200 coreos-metadata[1605]: Oct 02 19:18:22.960 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Oct 2 19:18:22.971600 coreos-metadata[1605]: Oct 02 19:18:22.971 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys: Attempt #1 Oct 2 19:18:22.972708 coreos-metadata[1605]: Oct 02 19:18:22.972 INFO Fetch successful Oct 2 19:18:22.972708 coreos-metadata[1605]: Oct 02 19:18:22.972 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys/0/openssh-key: Attempt #1 Oct 2 19:18:22.974061 coreos-metadata[1605]: Oct 02 19:18:22.973 INFO Fetch successful Oct 2 19:18:22.976184 unknown[1605]: wrote ssh authorized keys file for user: core Oct 2 19:18:23.023303 update-ssh-keys[1768]: Updated "/home/core/.ssh/authorized_keys" Oct 2 19:18:23.023753 systemd-networkd[1444]: eth0: Gained IPv6LL Oct 2 19:18:23.026272 systemd[1]: Finished coreos-metadata-sshkeys@core.service. Oct 2 19:18:23.031828 systemd[1]: Finished systemd-networkd-wait-online.service. Oct 2 19:18:23.035011 systemd[1]: Reached target network-online.target. Oct 2 19:18:23.038324 systemd[1]: Started amazon-ssm-agent.service. Oct 2 19:18:23.041342 systemd[1]: Started nvidia.service. Oct 2 19:18:23.229880 amazon-ssm-agent[1769]: 2023/10/02 19:18:23 Failed to load instance info from vault. RegistrationKey does not exist. Oct 2 19:18:23.230853 amazon-ssm-agent[1769]: Initializing new seelog logger Oct 2 19:18:23.235296 amazon-ssm-agent[1769]: New Seelog Logger Creation Complete Oct 2 19:18:23.235582 amazon-ssm-agent[1769]: 2023/10/02 19:18:23 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Oct 2 19:18:23.235712 amazon-ssm-agent[1769]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Oct 2 19:18:23.236191 amazon-ssm-agent[1769]: 2023/10/02 19:18:23 processing appconfig overrides Oct 2 19:18:23.263865 systemd[1]: nvidia.service: Deactivated successfully. Oct 2 19:18:23.359653 locksmithd[1658]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 2 19:18:23.475067 amazon-ssm-agent[1769]: 2023-10-02 19:18:23 INFO Agent is in hibernate mode. Reducing logging. Logging will be reduced to one log per backoff period Oct 2 19:18:23.475656 amazon-ssm-agent[1769]: 2023-10-02 19:18:23 INFO Entering SSM Agent hibernate - AccessDeniedException: User: arn:aws:sts::075585003325:assumed-role/jenkins-test/i-0699f0aa68184f444 is not authorized to perform: ssm:UpdateInstanceInformation on resource: arn:aws:ec2:us-west-2:075585003325:instance/i-0699f0aa68184f444 because no identity-based policy allows the ssm:UpdateInstanceInformation action Oct 2 19:18:23.475656 amazon-ssm-agent[1769]: status code: 400, request id: 8b2f0f07-0056-4c5d-a444-bfa946161402 Oct 2 19:18:24.845187 sshd_keygen[1630]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 2 19:18:24.868709 systemd[1]: Finished sshd-keygen.service. Oct 2 19:18:24.871826 systemd[1]: Starting issuegen.service... Oct 2 19:18:24.874798 systemd[1]: Started sshd@0-172.31.16.170:22-139.178.89.65:33062.service. Oct 2 19:18:24.885804 systemd[1]: issuegen.service: Deactivated successfully. Oct 2 19:18:24.886247 systemd[1]: Finished issuegen.service. Oct 2 19:18:24.891411 systemd[1]: Starting systemd-user-sessions.service... Oct 2 19:18:24.902379 systemd[1]: Finished systemd-user-sessions.service. Oct 2 19:18:24.916038 systemd[1]: Started getty@tty1.service. Oct 2 19:18:24.919646 systemd[1]: Started serial-getty@ttyS0.service. Oct 2 19:18:24.921377 systemd[1]: Reached target getty.target. Oct 2 19:18:24.922997 systemd[1]: Reached target multi-user.target. Oct 2 19:18:24.926492 systemd[1]: Starting systemd-update-utmp-runlevel.service... Oct 2 19:18:24.937537 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 2 19:18:24.937834 systemd[1]: Finished systemd-update-utmp-runlevel.service. Oct 2 19:18:24.939414 systemd[1]: Startup finished in 820ms (kernel) + 5.775s (initrd) + 9.622s (userspace) = 16.219s. Oct 2 19:18:25.213356 sshd[1801]: Accepted publickey for core from 139.178.89.65 port 33062 ssh2: RSA SHA256:x9/OT7ro8vjSge/fuA4/NJq92bLfWcOP18P7B4SEcY0 Oct 2 19:18:25.215780 sshd[1801]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 19:18:25.237876 systemd[1]: Created slice user-500.slice. Oct 2 19:18:25.240890 systemd[1]: Starting user-runtime-dir@500.service... Oct 2 19:18:25.246221 systemd-logind[1612]: New session 1 of user core. Oct 2 19:18:25.255521 systemd[1]: Finished user-runtime-dir@500.service. Oct 2 19:18:25.259650 systemd[1]: Starting user@500.service... Oct 2 19:18:25.268015 (systemd)[1810]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 2 19:18:25.375969 systemd[1810]: Queued start job for default target default.target. Oct 2 19:18:25.376592 systemd[1810]: Reached target paths.target. Oct 2 19:18:25.376623 systemd[1810]: Reached target sockets.target. Oct 2 19:18:25.376641 systemd[1810]: Reached target timers.target. Oct 2 19:18:25.376657 systemd[1810]: Reached target basic.target. Oct 2 19:18:25.376719 systemd[1810]: Reached target default.target. Oct 2 19:18:25.376756 systemd[1810]: Startup finished in 97ms. Oct 2 19:18:25.377408 systemd[1]: Started user@500.service. Oct 2 19:18:25.378490 systemd[1]: Started session-1.scope. Oct 2 19:18:25.529238 systemd[1]: Started sshd@1-172.31.16.170:22-139.178.89.65:33074.service. Oct 2 19:18:25.696129 sshd[1819]: Accepted publickey for core from 139.178.89.65 port 33074 ssh2: RSA SHA256:x9/OT7ro8vjSge/fuA4/NJq92bLfWcOP18P7B4SEcY0 Oct 2 19:18:25.697611 sshd[1819]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 19:18:25.703939 systemd-logind[1612]: New session 2 of user core. Oct 2 19:18:25.704701 systemd[1]: Started session-2.scope. Oct 2 19:18:25.844602 sshd[1819]: pam_unix(sshd:session): session closed for user core Oct 2 19:18:25.847961 systemd[1]: sshd@1-172.31.16.170:22-139.178.89.65:33074.service: Deactivated successfully. Oct 2 19:18:25.848840 systemd[1]: session-2.scope: Deactivated successfully. Oct 2 19:18:25.849528 systemd-logind[1612]: Session 2 logged out. Waiting for processes to exit. Oct 2 19:18:25.850464 systemd-logind[1612]: Removed session 2. Oct 2 19:18:25.869557 systemd[1]: Started sshd@2-172.31.16.170:22-139.178.89.65:33662.service. Oct 2 19:18:26.030045 sshd[1825]: Accepted publickey for core from 139.178.89.65 port 33662 ssh2: RSA SHA256:x9/OT7ro8vjSge/fuA4/NJq92bLfWcOP18P7B4SEcY0 Oct 2 19:18:26.031655 sshd[1825]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 19:18:26.039423 systemd-logind[1612]: New session 3 of user core. Oct 2 19:18:26.040800 systemd[1]: Started session-3.scope. Oct 2 19:18:26.160109 sshd[1825]: pam_unix(sshd:session): session closed for user core Oct 2 19:18:26.163952 systemd[1]: sshd@2-172.31.16.170:22-139.178.89.65:33662.service: Deactivated successfully. Oct 2 19:18:26.164779 systemd[1]: session-3.scope: Deactivated successfully. Oct 2 19:18:26.165434 systemd-logind[1612]: Session 3 logged out. Waiting for processes to exit. Oct 2 19:18:26.166312 systemd-logind[1612]: Removed session 3. Oct 2 19:18:26.187624 systemd[1]: Started sshd@3-172.31.16.170:22-139.178.89.65:33670.service. Oct 2 19:18:26.359941 sshd[1831]: Accepted publickey for core from 139.178.89.65 port 33670 ssh2: RSA SHA256:x9/OT7ro8vjSge/fuA4/NJq92bLfWcOP18P7B4SEcY0 Oct 2 19:18:26.362458 sshd[1831]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 19:18:26.368074 systemd[1]: Started session-4.scope. Oct 2 19:18:26.368815 systemd-logind[1612]: New session 4 of user core. Oct 2 19:18:26.505385 sshd[1831]: pam_unix(sshd:session): session closed for user core Oct 2 19:18:26.513405 systemd[1]: sshd@3-172.31.16.170:22-139.178.89.65:33670.service: Deactivated successfully. Oct 2 19:18:26.514598 systemd[1]: session-4.scope: Deactivated successfully. Oct 2 19:18:26.515692 systemd-logind[1612]: Session 4 logged out. Waiting for processes to exit. Oct 2 19:18:26.517153 systemd-logind[1612]: Removed session 4. Oct 2 19:18:26.527697 systemd[1]: Started sshd@4-172.31.16.170:22-139.178.89.65:33686.service. Oct 2 19:18:26.688977 sshd[1837]: Accepted publickey for core from 139.178.89.65 port 33686 ssh2: RSA SHA256:x9/OT7ro8vjSge/fuA4/NJq92bLfWcOP18P7B4SEcY0 Oct 2 19:18:26.690729 sshd[1837]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 19:18:26.696682 systemd[1]: Started session-5.scope. Oct 2 19:18:26.697361 systemd-logind[1612]: New session 5 of user core. Oct 2 19:18:26.814043 sudo[1840]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 2 19:18:26.814281 sudo[1840]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 19:18:26.823296 dbus-daemon[1606]: Ѝf\xdb\xceU: received setenforce notice (enforcing=-301864432) Oct 2 19:18:26.825673 sudo[1840]: pam_unix(sudo:session): session closed for user root Oct 2 19:18:26.849406 sshd[1837]: pam_unix(sshd:session): session closed for user core Oct 2 19:18:26.854689 systemd[1]: sshd@4-172.31.16.170:22-139.178.89.65:33686.service: Deactivated successfully. Oct 2 19:18:26.855775 systemd[1]: session-5.scope: Deactivated successfully. Oct 2 19:18:26.856825 systemd-logind[1612]: Session 5 logged out. Waiting for processes to exit. Oct 2 19:18:26.858109 systemd-logind[1612]: Removed session 5. Oct 2 19:18:26.876571 systemd[1]: Started sshd@5-172.31.16.170:22-139.178.89.65:33688.service. Oct 2 19:18:27.045929 sshd[1844]: Accepted publickey for core from 139.178.89.65 port 33688 ssh2: RSA SHA256:x9/OT7ro8vjSge/fuA4/NJq92bLfWcOP18P7B4SEcY0 Oct 2 19:18:27.048488 sshd[1844]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 2 19:18:27.058151 systemd-logind[1612]: New session 6 of user core. Oct 2 19:18:27.058736 systemd[1]: Started session-6.scope. Oct 2 19:18:27.173066 sudo[1848]: 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 19:18:27.173768 sudo[1848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 19:18:27.177311 sudo[1848]: pam_unix(sudo:session): session closed for user root Oct 2 19:18:27.185344 sudo[1847]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Oct 2 19:18:27.185764 sudo[1847]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 2 19:18:27.198325 systemd[1]: Stopping audit-rules.service... Oct 2 19:18:27.199000 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 19:18:27.201203 auditctl[1851]: No rules Oct 2 19:18:27.201712 kernel: kauditd_printk_skb: 175 callbacks suppressed Oct 2 19:18:27.201779 kernel: audit: type=1305 audit(1696274307.199:159): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 2 19:18:27.216385 kernel: audit: type=1300 audit(1696274307.199:159): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffe96d17810 a2=420 a3=0 items=0 ppid=1 pid=1851 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 19:18:27.216554 kernel: audit: type=1327 audit(1696274307.199:159): proctitle=2F7362696E2F617564697463746C002D44 Oct 2 19:18:27.216589 kernel: audit: type=1131 audit(1696274307.204:160): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 19:18:27.199000 audit[1851]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffe96d17810 a2=420 a3=0 items=0 ppid=1 pid=1851 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 19:18:27.199000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Oct 2 19:18:27.204000 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 19:18:27.205244 systemd[1]: audit-rules.service: Deactivated successfully. Oct 2 19:18:27.205517 systemd[1]: Stopped audit-rules.service. Oct 2 19:18:27.213023 systemd[1]: Starting audit-rules.service... Oct 2 19:18:27.244404 augenrules[1868]: No rules Oct 2 19:18:27.245545 systemd[1]: Finished audit-rules.service. Oct 2 19:18:27.244000 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 19:18:27.252762 kernel: audit: type=1130 audit(1696274307.244: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 19:18:27.252452 sudo[1847]: pam_unix(sudo:session): session closed for user root Oct 2 19:18:27.251000 audit[1847]: USER_END pid=1847 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 19:18:27.251000 audit[1847]: CRED_DISP pid=1847 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 19:18:27.266521 kernel: audit: type=1106 audit(1696274307.251:162): pid=1847 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 19:18:27.266651 kernel: audit: type=1104 audit(1696274307.251:163): pid=1847 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 19:18:27.276011 sshd[1844]: pam_unix(sshd:session): session closed for user core Oct 2 19:18:27.276000 audit[1844]: USER_END pid=1844 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 19:18:27.283326 systemd[1]: sshd@5-172.31.16.170:22-139.178.89.65:33688.service: Deactivated successfully. Oct 2 19:18:27.284611 systemd[1]: session-6.scope: Deactivated successfully. Oct 2 19:18:27.286794 systemd-logind[1612]: Session 6 logged out. Waiting for processes to exit. Oct 2 19:18:27.276000 audit[1844]: CRED_DISP pid=1844 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 19:18:27.288241 systemd-logind[1612]: Removed session 6. Oct 2 19:18:27.294929 kernel: audit: type=1106 audit(1696274307.276:164): pid=1844 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 19:18:27.295719 kernel: audit: type=1104 audit(1696274307.276:165): pid=1844 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 19:18:27.295897 kernel: audit: type=1131 audit(1696274307.282:166): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-172.31.16.170:22-139.178.89.65:33688 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 2 19:18:27.282000 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.16.170:22-139.178.89.65:33688 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'