Apr 12 18:51:03.818256 kernel: Linux version 5.15.154-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 Fri Apr 12 17:19:00 -00 2024 Apr 12 18:51:03.818275 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,115200 flatcar.first_boot=detected verity.usrhash=189121f7c8c0a24098d3bb1e040d34611f7c276be43815ff7fe409fce185edaf Apr 12 18:51:03.818283 kernel: BIOS-provided physical RAM map: Apr 12 18:51:03.818289 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Apr 12 18:51:03.818294 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Apr 12 18:51:03.818299 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Apr 12 18:51:03.818305 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdcfff] usable Apr 12 18:51:03.818311 kernel: BIOS-e820: [mem 0x000000009cfdd000-0x000000009cffffff] reserved Apr 12 18:51:03.818318 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Apr 12 18:51:03.818323 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Apr 12 18:51:03.818329 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Apr 12 18:51:03.818334 kernel: NX (Execute Disable) protection: active Apr 12 18:51:03.818339 kernel: SMBIOS 2.8 present. Apr 12 18:51:03.818345 kernel: DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Apr 12 18:51:03.818353 kernel: Hypervisor detected: KVM Apr 12 18:51:03.818359 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Apr 12 18:51:03.818365 kernel: kvm-clock: cpu 0, msr 7e191001, primary cpu clock Apr 12 18:51:03.818371 kernel: kvm-clock: using sched offset of 2315495958 cycles Apr 12 18:51:03.818377 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Apr 12 18:51:03.818383 kernel: tsc: Detected 2794.748 MHz processor Apr 12 18:51:03.818389 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Apr 12 18:51:03.818396 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Apr 12 18:51:03.818402 kernel: last_pfn = 0x9cfdd max_arch_pfn = 0x400000000 Apr 12 18:51:03.818409 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Apr 12 18:51:03.818415 kernel: Using GB pages for direct mapping Apr 12 18:51:03.818421 kernel: ACPI: Early table checksum verification disabled Apr 12 18:51:03.818427 kernel: ACPI: RSDP 0x00000000000F59C0 000014 (v00 BOCHS ) Apr 12 18:51:03.818433 kernel: ACPI: RSDT 0x000000009CFE1BDD 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 12 18:51:03.818439 kernel: ACPI: FACP 0x000000009CFE1A79 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 12 18:51:03.818445 kernel: ACPI: DSDT 0x000000009CFE0040 001A39 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 12 18:51:03.818451 kernel: ACPI: FACS 0x000000009CFE0000 000040 Apr 12 18:51:03.818457 kernel: ACPI: APIC 0x000000009CFE1AED 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 12 18:51:03.818464 kernel: ACPI: HPET 0x000000009CFE1B7D 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 12 18:51:03.818470 kernel: ACPI: WAET 0x000000009CFE1BB5 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 12 18:51:03.818476 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe1a79-0x9cfe1aec] Apr 12 18:51:03.818482 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe1a78] Apr 12 18:51:03.818488 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Apr 12 18:51:03.818494 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe1aed-0x9cfe1b7c] Apr 12 18:51:03.818499 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe1b7d-0x9cfe1bb4] Apr 12 18:51:03.818505 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe1bb5-0x9cfe1bdc] Apr 12 18:51:03.818515 kernel: No NUMA configuration found Apr 12 18:51:03.818521 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdcfff] Apr 12 18:51:03.818528 kernel: NODE_DATA(0) allocated [mem 0x9cfd7000-0x9cfdcfff] Apr 12 18:51:03.818534 kernel: Zone ranges: Apr 12 18:51:03.818540 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Apr 12 18:51:03.818547 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdcfff] Apr 12 18:51:03.818554 kernel: Normal empty Apr 12 18:51:03.818561 kernel: Movable zone start for each node Apr 12 18:51:03.818567 kernel: Early memory node ranges Apr 12 18:51:03.818573 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Apr 12 18:51:03.818580 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdcfff] Apr 12 18:51:03.818586 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdcfff] Apr 12 18:51:03.818592 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Apr 12 18:51:03.818599 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Apr 12 18:51:03.818605 kernel: On node 0, zone DMA32: 12323 pages in unavailable ranges Apr 12 18:51:03.818613 kernel: ACPI: PM-Timer IO Port: 0x608 Apr 12 18:51:03.818620 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Apr 12 18:51:03.818626 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Apr 12 18:51:03.818632 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Apr 12 18:51:03.818639 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Apr 12 18:51:03.818645 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Apr 12 18:51:03.818652 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Apr 12 18:51:03.818661 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Apr 12 18:51:03.818670 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Apr 12 18:51:03.818680 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Apr 12 18:51:03.818688 kernel: TSC deadline timer available Apr 12 18:51:03.818694 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Apr 12 18:51:03.818700 kernel: kvm-guest: KVM setup pv remote TLB flush Apr 12 18:51:03.818707 kernel: kvm-guest: setup PV sched yield Apr 12 18:51:03.818713 kernel: [mem 0x9d000000-0xfeffbfff] available for PCI devices Apr 12 18:51:03.818719 kernel: Booting paravirtualized kernel on KVM Apr 12 18:51:03.818726 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Apr 12 18:51:03.818732 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:4 nr_node_ids:1 Apr 12 18:51:03.818740 kernel: percpu: Embedded 56 pages/cpu s188696 r8192 d32488 u524288 Apr 12 18:51:03.818747 kernel: pcpu-alloc: s188696 r8192 d32488 u524288 alloc=1*2097152 Apr 12 18:51:03.818753 kernel: pcpu-alloc: [0] 0 1 2 3 Apr 12 18:51:03.818759 kernel: kvm-guest: setup async PF for cpu 0 Apr 12 18:51:03.818765 kernel: kvm-guest: stealtime: cpu 0, msr 9a41c0c0 Apr 12 18:51:03.818772 kernel: kvm-guest: PV spinlocks enabled Apr 12 18:51:03.818778 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Apr 12 18:51:03.818784 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632733 Apr 12 18:51:03.818812 kernel: Policy zone: DMA32 Apr 12 18:51:03.818820 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,115200 flatcar.first_boot=detected verity.usrhash=189121f7c8c0a24098d3bb1e040d34611f7c276be43815ff7fe409fce185edaf Apr 12 18:51:03.818828 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Apr 12 18:51:03.818835 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 12 18:51:03.818841 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 12 18:51:03.818847 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 12 18:51:03.818854 kernel: Memory: 2436704K/2571756K available (12294K kernel code, 2275K rwdata, 13708K rodata, 47440K init, 4148K bss, 134792K reserved, 0K cma-reserved) Apr 12 18:51:03.818861 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Apr 12 18:51:03.818867 kernel: ftrace: allocating 34508 entries in 135 pages Apr 12 18:51:03.818874 kernel: ftrace: allocated 135 pages with 4 groups Apr 12 18:51:03.818881 kernel: rcu: Hierarchical RCU implementation. Apr 12 18:51:03.818888 kernel: rcu: RCU event tracing is enabled. Apr 12 18:51:03.818894 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Apr 12 18:51:03.818901 kernel: Rude variant of Tasks RCU enabled. Apr 12 18:51:03.818907 kernel: Tracing variant of Tasks RCU enabled. Apr 12 18:51:03.818914 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 12 18:51:03.818920 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Apr 12 18:51:03.818926 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Apr 12 18:51:03.818933 kernel: random: crng init done Apr 12 18:51:03.818940 kernel: Console: colour VGA+ 80x25 Apr 12 18:51:03.818947 kernel: printk: console [ttyS0] enabled Apr 12 18:51:03.818953 kernel: ACPI: Core revision 20210730 Apr 12 18:51:03.818960 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Apr 12 18:51:03.818966 kernel: APIC: Switch to symmetric I/O mode setup Apr 12 18:51:03.818972 kernel: x2apic enabled Apr 12 18:51:03.818979 kernel: Switched APIC routing to physical x2apic. Apr 12 18:51:03.818985 kernel: kvm-guest: setup PV IPIs Apr 12 18:51:03.818991 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Apr 12 18:51:03.818999 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Apr 12 18:51:03.819005 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) Apr 12 18:51:03.819012 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Apr 12 18:51:03.819018 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Apr 12 18:51:03.819024 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Apr 12 18:51:03.819031 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Apr 12 18:51:03.819037 kernel: Spectre V2 : Mitigation: Retpolines Apr 12 18:51:03.819044 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Apr 12 18:51:03.819050 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Apr 12 18:51:03.819062 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Apr 12 18:51:03.819069 kernel: RETBleed: Mitigation: untrained return thunk Apr 12 18:51:03.819077 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Apr 12 18:51:03.819084 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl and seccomp Apr 12 18:51:03.819091 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Apr 12 18:51:03.819098 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Apr 12 18:51:03.819104 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Apr 12 18:51:03.819111 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Apr 12 18:51:03.819118 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Apr 12 18:51:03.819126 kernel: Freeing SMP alternatives memory: 32K Apr 12 18:51:03.819133 kernel: pid_max: default: 32768 minimum: 301 Apr 12 18:51:03.819140 kernel: LSM: Security Framework initializing Apr 12 18:51:03.819146 kernel: SELinux: Initializing. Apr 12 18:51:03.819153 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 12 18:51:03.819160 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 12 18:51:03.819167 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Apr 12 18:51:03.819175 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Apr 12 18:51:03.819182 kernel: ... version: 0 Apr 12 18:51:03.819189 kernel: ... bit width: 48 Apr 12 18:51:03.819195 kernel: ... generic registers: 6 Apr 12 18:51:03.819202 kernel: ... value mask: 0000ffffffffffff Apr 12 18:51:03.819209 kernel: ... max period: 00007fffffffffff Apr 12 18:51:03.819216 kernel: ... fixed-purpose events: 0 Apr 12 18:51:03.819222 kernel: ... event mask: 000000000000003f Apr 12 18:51:03.819229 kernel: signal: max sigframe size: 1776 Apr 12 18:51:03.819237 kernel: rcu: Hierarchical SRCU implementation. Apr 12 18:51:03.819244 kernel: smp: Bringing up secondary CPUs ... Apr 12 18:51:03.819250 kernel: x86: Booting SMP configuration: Apr 12 18:51:03.819257 kernel: .... node #0, CPUs: #1 Apr 12 18:51:03.819264 kernel: kvm-clock: cpu 1, msr 7e191041, secondary cpu clock Apr 12 18:51:03.819270 kernel: kvm-guest: setup async PF for cpu 1 Apr 12 18:51:03.819277 kernel: kvm-guest: stealtime: cpu 1, msr 9a49c0c0 Apr 12 18:51:03.819284 kernel: #2 Apr 12 18:51:03.819291 kernel: kvm-clock: cpu 2, msr 7e191081, secondary cpu clock Apr 12 18:51:03.819297 kernel: kvm-guest: setup async PF for cpu 2 Apr 12 18:51:03.819305 kernel: kvm-guest: stealtime: cpu 2, msr 9a51c0c0 Apr 12 18:51:03.819312 kernel: #3 Apr 12 18:51:03.819318 kernel: kvm-clock: cpu 3, msr 7e1910c1, secondary cpu clock Apr 12 18:51:03.819325 kernel: kvm-guest: setup async PF for cpu 3 Apr 12 18:51:03.819332 kernel: kvm-guest: stealtime: cpu 3, msr 9a59c0c0 Apr 12 18:51:03.819338 kernel: smp: Brought up 1 node, 4 CPUs Apr 12 18:51:03.819345 kernel: smpboot: Max logical packages: 1 Apr 12 18:51:03.819352 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) Apr 12 18:51:03.819359 kernel: devtmpfs: initialized Apr 12 18:51:03.819367 kernel: x86/mm: Memory block size: 128MB Apr 12 18:51:03.819373 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 12 18:51:03.819380 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Apr 12 18:51:03.819387 kernel: pinctrl core: initialized pinctrl subsystem Apr 12 18:51:03.819394 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 12 18:51:03.819401 kernel: audit: initializing netlink subsys (disabled) Apr 12 18:51:03.819407 kernel: audit: type=2000 audit(1712947863.815:1): state=initialized audit_enabled=0 res=1 Apr 12 18:51:03.819414 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 12 18:51:03.819421 kernel: thermal_sys: Registered thermal governor 'user_space' Apr 12 18:51:03.819430 kernel: cpuidle: using governor menu Apr 12 18:51:03.819436 kernel: ACPI: bus type PCI registered Apr 12 18:51:03.819443 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 12 18:51:03.819450 kernel: dca service started, version 1.12.1 Apr 12 18:51:03.819456 kernel: PCI: Using configuration type 1 for base access Apr 12 18:51:03.819463 kernel: PCI: Using configuration type 1 for extended access Apr 12 18:51:03.819470 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Apr 12 18:51:03.819477 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Apr 12 18:51:03.819483 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Apr 12 18:51:03.819492 kernel: ACPI: Added _OSI(Module Device) Apr 12 18:51:03.819498 kernel: ACPI: Added _OSI(Processor Device) Apr 12 18:51:03.819505 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Apr 12 18:51:03.819512 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 12 18:51:03.819519 kernel: ACPI: Added _OSI(Linux-Dell-Video) Apr 12 18:51:03.819525 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Apr 12 18:51:03.819532 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Apr 12 18:51:03.819539 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 12 18:51:03.819545 kernel: ACPI: Interpreter enabled Apr 12 18:51:03.819553 kernel: ACPI: PM: (supports S0 S3 S5) Apr 12 18:51:03.819560 kernel: ACPI: Using IOAPIC for interrupt routing Apr 12 18:51:03.819567 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Apr 12 18:51:03.819574 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Apr 12 18:51:03.819580 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Apr 12 18:51:03.819695 kernel: acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 12 18:51:03.819707 kernel: acpiphp: Slot [3] registered Apr 12 18:51:03.819714 kernel: acpiphp: Slot [4] registered Apr 12 18:51:03.819722 kernel: acpiphp: Slot [5] registered Apr 12 18:51:03.819729 kernel: acpiphp: Slot [6] registered Apr 12 18:51:03.819736 kernel: acpiphp: Slot [7] registered Apr 12 18:51:03.819742 kernel: acpiphp: Slot [8] registered Apr 12 18:51:03.819749 kernel: acpiphp: Slot [9] registered Apr 12 18:51:03.819756 kernel: acpiphp: Slot [10] registered Apr 12 18:51:03.819762 kernel: acpiphp: Slot [11] registered Apr 12 18:51:03.819769 kernel: acpiphp: Slot [12] registered Apr 12 18:51:03.819776 kernel: acpiphp: Slot [13] registered Apr 12 18:51:03.819782 kernel: acpiphp: Slot [14] registered Apr 12 18:51:03.819806 kernel: acpiphp: Slot [15] registered Apr 12 18:51:03.819813 kernel: acpiphp: Slot [16] registered Apr 12 18:51:03.819820 kernel: acpiphp: Slot [17] registered Apr 12 18:51:03.819827 kernel: acpiphp: Slot [18] registered Apr 12 18:51:03.819833 kernel: acpiphp: Slot [19] registered Apr 12 18:51:03.819840 kernel: acpiphp: Slot [20] registered Apr 12 18:51:03.819847 kernel: acpiphp: Slot [21] registered Apr 12 18:51:03.819853 kernel: acpiphp: Slot [22] registered Apr 12 18:51:03.819860 kernel: acpiphp: Slot [23] registered Apr 12 18:51:03.819868 kernel: acpiphp: Slot [24] registered Apr 12 18:51:03.819875 kernel: acpiphp: Slot [25] registered Apr 12 18:51:03.819881 kernel: acpiphp: Slot [26] registered Apr 12 18:51:03.819888 kernel: acpiphp: Slot [27] registered Apr 12 18:51:03.819894 kernel: acpiphp: Slot [28] registered Apr 12 18:51:03.819901 kernel: acpiphp: Slot [29] registered Apr 12 18:51:03.819908 kernel: acpiphp: Slot [30] registered Apr 12 18:51:03.819914 kernel: acpiphp: Slot [31] registered Apr 12 18:51:03.819921 kernel: PCI host bridge to bus 0000:00 Apr 12 18:51:03.820003 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Apr 12 18:51:03.820068 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Apr 12 18:51:03.820130 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Apr 12 18:51:03.820189 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xfebfffff window] Apr 12 18:51:03.820249 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] Apr 12 18:51:03.820310 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Apr 12 18:51:03.820393 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Apr 12 18:51:03.820471 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Apr 12 18:51:03.820545 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Apr 12 18:51:03.820619 kernel: pci 0000:00:01.1: reg 0x20: [io 0xc0c0-0xc0cf] Apr 12 18:51:03.820686 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Apr 12 18:51:03.820754 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Apr 12 18:51:03.820848 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Apr 12 18:51:03.820920 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Apr 12 18:51:03.820994 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Apr 12 18:51:03.821061 kernel: pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI Apr 12 18:51:03.821129 kernel: pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB Apr 12 18:51:03.821203 kernel: pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 Apr 12 18:51:03.821270 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Apr 12 18:51:03.821339 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Apr 12 18:51:03.821407 kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Apr 12 18:51:03.821476 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Apr 12 18:51:03.821552 kernel: pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 Apr 12 18:51:03.821621 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc080-0xc09f] Apr 12 18:51:03.821691 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Apr 12 18:51:03.821759 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Apr 12 18:51:03.821870 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 Apr 12 18:51:03.821943 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc000-0xc07f] Apr 12 18:51:03.822012 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Apr 12 18:51:03.822077 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Apr 12 18:51:03.822161 kernel: pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 Apr 12 18:51:03.822230 kernel: pci 0000:00:05.0: reg 0x10: [io 0xc0a0-0xc0bf] Apr 12 18:51:03.822298 kernel: pci 0000:00:05.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Apr 12 18:51:03.822367 kernel: pci 0000:00:05.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Apr 12 18:51:03.822438 kernel: pci 0000:00:05.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Apr 12 18:51:03.822447 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Apr 12 18:51:03.822454 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Apr 12 18:51:03.822462 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Apr 12 18:51:03.822469 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Apr 12 18:51:03.822476 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Apr 12 18:51:03.822482 kernel: iommu: Default domain type: Translated Apr 12 18:51:03.822489 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Apr 12 18:51:03.822556 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Apr 12 18:51:03.822628 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Apr 12 18:51:03.822695 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Apr 12 18:51:03.822704 kernel: vgaarb: loaded Apr 12 18:51:03.822711 kernel: pps_core: LinuxPPS API ver. 1 registered Apr 12 18:51:03.822718 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Apr 12 18:51:03.822724 kernel: PTP clock support registered Apr 12 18:51:03.822731 kernel: PCI: Using ACPI for IRQ routing Apr 12 18:51:03.822738 kernel: PCI: pci_cache_line_size set to 64 bytes Apr 12 18:51:03.822747 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Apr 12 18:51:03.822754 kernel: e820: reserve RAM buffer [mem 0x9cfdd000-0x9fffffff] Apr 12 18:51:03.822760 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Apr 12 18:51:03.822767 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Apr 12 18:51:03.822774 kernel: clocksource: Switched to clocksource kvm-clock Apr 12 18:51:03.822781 kernel: VFS: Disk quotas dquot_6.6.0 Apr 12 18:51:03.822788 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 12 18:51:03.822811 kernel: pnp: PnP ACPI init Apr 12 18:51:03.822885 kernel: pnp 00:02: [dma 2] Apr 12 18:51:03.822897 kernel: pnp: PnP ACPI: found 6 devices Apr 12 18:51:03.822904 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Apr 12 18:51:03.822911 kernel: NET: Registered PF_INET protocol family Apr 12 18:51:03.822918 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 12 18:51:03.822925 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Apr 12 18:51:03.822931 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 12 18:51:03.822938 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Apr 12 18:51:03.822945 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Apr 12 18:51:03.822953 kernel: TCP: Hash tables configured (established 32768 bind 32768) Apr 12 18:51:03.822960 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 12 18:51:03.822967 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 12 18:51:03.822974 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 12 18:51:03.822980 kernel: NET: Registered PF_XDP protocol family Apr 12 18:51:03.823044 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Apr 12 18:51:03.823104 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Apr 12 18:51:03.823164 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Apr 12 18:51:03.823222 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xfebfffff window] Apr 12 18:51:03.823288 kernel: pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] Apr 12 18:51:03.823358 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Apr 12 18:51:03.823426 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Apr 12 18:51:03.823495 kernel: pci 0000:00:01.0: Activating ISA DMA hang workarounds Apr 12 18:51:03.823504 kernel: PCI: CLS 0 bytes, default 64 Apr 12 18:51:03.823511 kernel: Initialise system trusted keyrings Apr 12 18:51:03.823518 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Apr 12 18:51:03.823524 kernel: Key type asymmetric registered Apr 12 18:51:03.823533 kernel: Asymmetric key parser 'x509' registered Apr 12 18:51:03.823540 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Apr 12 18:51:03.823547 kernel: io scheduler mq-deadline registered Apr 12 18:51:03.823553 kernel: io scheduler kyber registered Apr 12 18:51:03.823560 kernel: io scheduler bfq registered Apr 12 18:51:03.823567 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Apr 12 18:51:03.823574 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Apr 12 18:51:03.823580 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 10 Apr 12 18:51:03.823587 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Apr 12 18:51:03.823595 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 12 18:51:03.823602 kernel: 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Apr 12 18:51:03.823609 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Apr 12 18:51:03.823616 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Apr 12 18:51:03.823623 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Apr 12 18:51:03.823629 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Apr 12 18:51:03.823699 kernel: rtc_cmos 00:05: RTC can wake from S4 Apr 12 18:51:03.823763 kernel: rtc_cmos 00:05: registered as rtc0 Apr 12 18:51:03.823849 kernel: rtc_cmos 00:05: setting system clock to 2024-04-12T18:51:03 UTC (1712947863) Apr 12 18:51:03.823912 kernel: rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Apr 12 18:51:03.823921 kernel: NET: Registered PF_INET6 protocol family Apr 12 18:51:03.823929 kernel: Segment Routing with IPv6 Apr 12 18:51:03.823935 kernel: In-situ OAM (IOAM) with IPv6 Apr 12 18:51:03.823942 kernel: NET: Registered PF_PACKET protocol family Apr 12 18:51:03.823949 kernel: Key type dns_resolver registered Apr 12 18:51:03.823955 kernel: IPI shorthand broadcast: enabled Apr 12 18:51:03.823962 kernel: sched_clock: Marking stable (507001169, 97206866)->(657859156, -53651121) Apr 12 18:51:03.823971 kernel: registered taskstats version 1 Apr 12 18:51:03.823978 kernel: Loading compiled-in X.509 certificates Apr 12 18:51:03.823985 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.154-flatcar: 1fa140a38fc6bd27c8b56127e4d1eb4f665c7ec4' Apr 12 18:51:03.823991 kernel: Key type .fscrypt registered Apr 12 18:51:03.823998 kernel: Key type fscrypt-provisioning registered Apr 12 18:51:03.824005 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 12 18:51:03.824012 kernel: ima: Allocated hash algorithm: sha1 Apr 12 18:51:03.824019 kernel: ima: No architecture policies found Apr 12 18:51:03.824027 kernel: Freeing unused kernel image (initmem) memory: 47440K Apr 12 18:51:03.824033 kernel: Write protecting the kernel read-only data: 28672k Apr 12 18:51:03.824040 kernel: Freeing unused kernel image (text/rodata gap) memory: 2040K Apr 12 18:51:03.824047 kernel: Freeing unused kernel image (rodata/data gap) memory: 628K Apr 12 18:51:03.824054 kernel: Run /init as init process Apr 12 18:51:03.824060 kernel: with arguments: Apr 12 18:51:03.824067 kernel: /init Apr 12 18:51:03.824074 kernel: with environment: Apr 12 18:51:03.824090 kernel: HOME=/ Apr 12 18:51:03.824097 kernel: TERM=linux Apr 12 18:51:03.824105 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Apr 12 18:51:03.824114 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) Apr 12 18:51:03.824123 systemd[1]: Detected virtualization kvm. Apr 12 18:51:03.824131 systemd[1]: Detected architecture x86-64. Apr 12 18:51:03.824138 systemd[1]: Running in initrd. Apr 12 18:51:03.824145 systemd[1]: No hostname configured, using default hostname. Apr 12 18:51:03.824153 systemd[1]: Hostname set to . Apr 12 18:51:03.824162 systemd[1]: Initializing machine ID from VM UUID. Apr 12 18:51:03.824169 systemd[1]: Queued start job for default target initrd.target. Apr 12 18:51:03.824176 systemd[1]: Started systemd-ask-password-console.path. Apr 12 18:51:03.824184 systemd[1]: Reached target cryptsetup.target. Apr 12 18:51:03.824191 systemd[1]: Reached target paths.target. Apr 12 18:51:03.824198 systemd[1]: Reached target slices.target. Apr 12 18:51:03.824206 systemd[1]: Reached target swap.target. Apr 12 18:51:03.824213 systemd[1]: Reached target timers.target. Apr 12 18:51:03.824222 systemd[1]: Listening on iscsid.socket. Apr 12 18:51:03.824230 systemd[1]: Listening on iscsiuio.socket. Apr 12 18:51:03.824237 systemd[1]: Listening on systemd-journald-audit.socket. Apr 12 18:51:03.824245 systemd[1]: Listening on systemd-journald-dev-log.socket. Apr 12 18:51:03.824252 systemd[1]: Listening on systemd-journald.socket. Apr 12 18:51:03.824259 systemd[1]: Listening on systemd-networkd.socket. Apr 12 18:51:03.824267 systemd[1]: Listening on systemd-udevd-control.socket. Apr 12 18:51:03.824276 systemd[1]: Listening on systemd-udevd-kernel.socket. Apr 12 18:51:03.824283 systemd[1]: Reached target sockets.target. Apr 12 18:51:03.824291 systemd[1]: Starting kmod-static-nodes.service... Apr 12 18:51:03.824298 systemd[1]: Finished network-cleanup.service. Apr 12 18:51:03.824305 systemd[1]: Starting systemd-fsck-usr.service... Apr 12 18:51:03.824313 systemd[1]: Starting systemd-journald.service... Apr 12 18:51:03.824321 systemd[1]: Starting systemd-modules-load.service... Apr 12 18:51:03.824330 systemd[1]: Starting systemd-resolved.service... Apr 12 18:51:03.824337 systemd[1]: Starting systemd-vconsole-setup.service... Apr 12 18:51:03.824345 systemd[1]: Finished kmod-static-nodes.service. Apr 12 18:51:03.824352 systemd[1]: Finished systemd-fsck-usr.service. Apr 12 18:51:03.824362 systemd-journald[198]: Journal started Apr 12 18:51:03.824398 systemd-journald[198]: Runtime Journal (/run/log/journal/f7b4ac0ff1c7487e8b4dff6e1f05a733) is 6.0M, max 48.5M, 42.5M free. Apr 12 18:51:03.851000 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' Apr 12 18:51:03.854481 kernel: audit: type=1130 audit(1712947863.851:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:03.854511 systemd[1]: Started systemd-journald.service. Apr 12 18:51:03.854500 systemd-modules-load[199]: Inserted module 'overlay' Apr 12 18:51:03.893528 kernel: audit: type=1130 audit(1712947863.855:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:03.893542 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Apr 12 18:51:03.893555 kernel: Bridge firewalling registered Apr 12 18:51:03.855000 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' Apr 12 18:51:03.859757 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Apr 12 18:51:03.869982 systemd-resolved[200]: Positive Trust Anchors: Apr 12 18:51:03.899863 kernel: audit: type=1130 audit(1712947863.894:4): 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' Apr 12 18:51:03.894000 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' Apr 12 18:51:03.869997 systemd-resolved[200]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 12 18:51:03.870024 systemd-resolved[200]: 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 Apr 12 18:51:03.872200 systemd-resolved[200]: Defaulting to hostname 'linux'. Apr 12 18:51:03.899000 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' Apr 12 18:51:03.893470 systemd-modules-load[199]: Inserted module 'br_netfilter' Apr 12 18:51:03.916640 kernel: audit: type=1130 audit(1712947863.899:5): 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' Apr 12 18:51:03.916665 kernel: audit: type=1130 audit(1712947863.899:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:03.899000 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' Apr 12 18:51:03.894665 systemd[1]: Started systemd-resolved.service. Apr 12 18:51:03.895727 systemd[1]: Finished systemd-vconsole-setup.service. Apr 12 18:51:03.900239 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Apr 12 18:51:03.900511 systemd[1]: Reached target nss-lookup.target. Apr 12 18:51:03.901374 systemd[1]: Starting dracut-cmdline-ask.service... Apr 12 18:51:03.924816 kernel: SCSI subsystem initialized Apr 12 18:51:03.927694 systemd[1]: Finished dracut-cmdline-ask.service. Apr 12 18:51:03.932811 kernel: audit: type=1130 audit(1712947863.927:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:03.927000 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' Apr 12 18:51:03.929177 systemd[1]: Starting dracut-cmdline.service... Apr 12 18:51:03.936466 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 12 18:51:03.936498 kernel: device-mapper: uevent: version 1.0.3 Apr 12 18:51:03.937335 dracut-cmdline[217]: dracut-dracut-053 Apr 12 18:51:03.938478 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Apr 12 18:51:03.939264 dracut-cmdline[217]: 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,115200 flatcar.first_boot=detected verity.usrhash=189121f7c8c0a24098d3bb1e040d34611f7c276be43815ff7fe409fce185edaf Apr 12 18:51:03.944188 systemd-modules-load[199]: Inserted module 'dm_multipath' Apr 12 18:51:03.944915 systemd[1]: Finished systemd-modules-load.service. Apr 12 18:51:03.949980 kernel: audit: type=1130 audit(1712947863.944:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:03.944000 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' Apr 12 18:51:03.949638 systemd[1]: Starting systemd-sysctl.service... Apr 12 18:51:03.956287 systemd[1]: Finished systemd-sysctl.service. Apr 12 18:51:03.956000 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' Apr 12 18:51:03.960813 kernel: audit: type=1130 audit(1712947863.956:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:04.003835 kernel: Loading iSCSI transport class v2.0-870. Apr 12 18:51:04.025866 kernel: iscsi: registered transport (tcp) Apr 12 18:51:04.046821 kernel: iscsi: registered transport (qla4xxx) Apr 12 18:51:04.046839 kernel: QLogic iSCSI HBA Driver Apr 12 18:51:04.076281 systemd[1]: Finished dracut-cmdline.service. Apr 12 18:51:04.077000 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' Apr 12 18:51:04.079019 systemd[1]: Starting dracut-pre-udev.service... Apr 12 18:51:04.082577 kernel: audit: type=1130 audit(1712947864.077:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:04.128824 kernel: raid6: avx2x4 gen() 17945 MB/s Apr 12 18:51:04.145825 kernel: raid6: avx2x4 xor() 5437 MB/s Apr 12 18:51:04.162828 kernel: raid6: avx2x2 gen() 16847 MB/s Apr 12 18:51:04.179835 kernel: raid6: avx2x2 xor() 12139 MB/s Apr 12 18:51:04.196824 kernel: raid6: avx2x1 gen() 12928 MB/s Apr 12 18:51:04.213830 kernel: raid6: avx2x1 xor() 9889 MB/s Apr 12 18:51:04.230829 kernel: raid6: sse2x4 gen() 8900 MB/s Apr 12 18:51:04.247830 kernel: raid6: sse2x4 xor() 4268 MB/s Apr 12 18:51:04.264818 kernel: raid6: sse2x2 gen() 9764 MB/s Apr 12 18:51:04.281822 kernel: raid6: sse2x2 xor() 9704 MB/s Apr 12 18:51:04.298816 kernel: raid6: sse2x1 gen() 12219 MB/s Apr 12 18:51:04.316270 kernel: raid6: sse2x1 xor() 7746 MB/s Apr 12 18:51:04.316326 kernel: raid6: using algorithm avx2x4 gen() 17945 MB/s Apr 12 18:51:04.316338 kernel: raid6: .... xor() 5437 MB/s, rmw enabled Apr 12 18:51:04.316989 kernel: raid6: using avx2x2 recovery algorithm Apr 12 18:51:04.329821 kernel: xor: automatically using best checksumming function avx Apr 12 18:51:04.432839 kernel: Btrfs loaded, crc32c=crc32c-intel, zoned=no, fsverity=no Apr 12 18:51:04.441128 systemd[1]: Finished dracut-pre-udev.service. Apr 12 18:51:04.440000 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' Apr 12 18:51:04.442000 audit: BPF prog-id=7 op=LOAD Apr 12 18:51:04.442000 audit: BPF prog-id=8 op=LOAD Apr 12 18:51:04.443289 systemd[1]: Starting systemd-udevd.service... Apr 12 18:51:04.455060 systemd-udevd[401]: Using default interface naming scheme 'v252'. Apr 12 18:51:04.459870 systemd[1]: Started systemd-udevd.service. Apr 12 18:51:04.459000 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' Apr 12 18:51:04.460725 systemd[1]: Starting dracut-pre-trigger.service... Apr 12 18:51:04.468975 dracut-pre-trigger[402]: rd.md=0: removing MD RAID activation Apr 12 18:51:04.491762 systemd[1]: Finished dracut-pre-trigger.service. Apr 12 18:51:04.491000 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' Apr 12 18:51:04.493475 systemd[1]: Starting systemd-udev-trigger.service... Apr 12 18:51:04.526575 systemd[1]: Finished systemd-udev-trigger.service. Apr 12 18:51:04.547000 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' Apr 12 18:51:04.566709 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Apr 12 18:51:04.570820 kernel: cryptd: max_cpu_qlen set to 1000 Apr 12 18:51:04.574810 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 12 18:51:04.588823 kernel: AVX2 version of gcm_enc/dec engaged. Apr 12 18:51:04.588857 kernel: AES CTR mode by8 optimization enabled Apr 12 18:51:04.594817 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (447) Apr 12 18:51:04.598107 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Apr 12 18:51:04.636213 kernel: libata version 3.00 loaded. Apr 12 18:51:04.636241 kernel: ata_piix 0000:00:01.1: version 2.13 Apr 12 18:51:04.636357 kernel: scsi host0: ata_piix Apr 12 18:51:04.636442 kernel: scsi host1: ata_piix Apr 12 18:51:04.636525 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0c0 irq 14 Apr 12 18:51:04.636535 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0c8 irq 15 Apr 12 18:51:04.635834 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Apr 12 18:51:04.640919 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Apr 12 18:51:04.646839 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Apr 12 18:51:04.687476 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Apr 12 18:51:04.688749 systemd[1]: Starting disk-uuid.service... Apr 12 18:51:04.821917 kernel: ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Apr 12 18:51:04.826596 kernel: scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Apr 12 18:51:04.857451 kernel: sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Apr 12 18:51:04.857647 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Apr 12 18:51:04.873829 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 12 18:51:04.874838 kernel: sr 1:0:0:0: Attached scsi CD-ROM sr0 Apr 12 18:51:04.961820 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 12 18:51:06.105829 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 12 18:51:06.105906 disk-uuid[531]: The operation has completed successfully. Apr 12 18:51:06.130054 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 12 18:51:06.155000 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' Apr 12 18:51:06.155000 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' Apr 12 18:51:06.130137 systemd[1]: Finished disk-uuid.service. Apr 12 18:51:06.160339 systemd[1]: Starting verity-setup.service... Apr 12 18:51:06.192827 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Apr 12 18:51:06.213892 systemd[1]: Found device dev-mapper-usr.device. Apr 12 18:51:06.216030 systemd[1]: Mounting sysusr-usr.mount... Apr 12 18:51:06.219546 systemd[1]: Finished verity-setup.service. Apr 12 18:51:06.221000 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' Apr 12 18:51:06.286816 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Apr 12 18:51:06.287054 systemd[1]: Mounted sysusr-usr.mount. Apr 12 18:51:06.288492 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Apr 12 18:51:06.289140 systemd[1]: Starting ignition-setup.service... Apr 12 18:51:06.290807 systemd[1]: Starting parse-ip-for-networkd.service... Apr 12 18:51:06.299528 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 12 18:51:06.299551 kernel: BTRFS info (device vda6): using free space tree Apr 12 18:51:06.299561 kernel: BTRFS info (device vda6): has skinny extents Apr 12 18:51:06.306710 systemd[1]: mnt-oem.mount: Deactivated successfully. Apr 12 18:51:06.344670 systemd[1]: Finished parse-ip-for-networkd.service. Apr 12 18:51:06.343000 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' Apr 12 18:51:06.346000 audit: BPF prog-id=9 op=LOAD Apr 12 18:51:06.346774 systemd[1]: Starting systemd-networkd.service... Apr 12 18:51:06.365173 systemd-networkd[702]: lo: Link UP Apr 12 18:51:06.365180 systemd-networkd[702]: lo: Gained carrier Apr 12 18:51:06.374000 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' Apr 12 18:51:06.365538 systemd-networkd[702]: Enumeration completed Apr 12 18:51:06.365604 systemd[1]: Started systemd-networkd.service. Apr 12 18:51:06.365710 systemd-networkd[702]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 12 18:51:06.375082 systemd-networkd[702]: eth0: Link UP Apr 12 18:51:06.375084 systemd-networkd[702]: eth0: Gained carrier Apr 12 18:51:06.375753 systemd[1]: Reached target network.target. Apr 12 18:51:06.377681 systemd[1]: Starting iscsiuio.service... Apr 12 18:51:06.413511 systemd[1]: Started iscsiuio.service. Apr 12 18:51:06.436000 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' Apr 12 18:51:06.436995 systemd[1]: Starting iscsid.service... Apr 12 18:51:06.441688 iscsid[707]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Apr 12 18:51:06.441688 iscsid[707]: 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]. Apr 12 18:51:06.441688 iscsid[707]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Apr 12 18:51:06.441688 iscsid[707]: If using hardware iscsi like qla4xxx this message can be ignored. Apr 12 18:51:06.441688 iscsid[707]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Apr 12 18:51:06.441688 iscsid[707]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Apr 12 18:51:06.448000 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' Apr 12 18:51:06.443748 systemd[1]: Started iscsid.service. Apr 12 18:51:06.450842 systemd[1]: Starting dracut-initqueue.service... Apr 12 18:51:06.455477 systemd-networkd[702]: eth0: DHCPv4 address 10.0.0.87/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 12 18:51:06.463579 systemd[1]: Finished dracut-initqueue.service. Apr 12 18:51:06.463000 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' Apr 12 18:51:06.464104 systemd[1]: Reached target remote-fs-pre.target. Apr 12 18:51:06.465545 systemd[1]: Reached target remote-cryptsetup.target. Apr 12 18:51:06.466912 systemd[1]: Reached target remote-fs.target. Apr 12 18:51:06.469544 systemd[1]: Starting dracut-pre-mount.service... Apr 12 18:51:06.517614 systemd[1]: Finished dracut-pre-mount.service. Apr 12 18:51:06.519000 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' Apr 12 18:51:06.523873 systemd[1]: Finished ignition-setup.service. Apr 12 18:51:06.523000 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' Apr 12 18:51:06.524721 systemd[1]: Starting ignition-fetch-offline.service... Apr 12 18:51:06.598908 ignition[722]: Ignition 2.14.0 Apr 12 18:51:06.598918 ignition[722]: Stage: fetch-offline Apr 12 18:51:06.598980 ignition[722]: no configs at "/usr/lib/ignition/base.d" Apr 12 18:51:06.598988 ignition[722]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 12 18:51:06.599096 ignition[722]: parsed url from cmdline: "" Apr 12 18:51:06.599099 ignition[722]: no config URL provided Apr 12 18:51:06.599103 ignition[722]: reading system config file "/usr/lib/ignition/user.ign" Apr 12 18:51:06.599110 ignition[722]: no config at "/usr/lib/ignition/user.ign" Apr 12 18:51:06.599126 ignition[722]: op(1): [started] loading QEMU firmware config module Apr 12 18:51:06.599130 ignition[722]: op(1): executing: "modprobe" "qemu_fw_cfg" Apr 12 18:51:06.608203 ignition[722]: op(1): [finished] loading QEMU firmware config module Apr 12 18:51:06.609461 ignition[722]: parsing config with SHA512: 7f51604986b9401b1cdf3b184bc4d550ba9c0f0a7d40982c67104d511fa4351f36b1c72662557fea770b3e8db6ca848d0a30847ee711a173b75cd8b0913c4893 Apr 12 18:51:06.618268 unknown[722]: fetched base config from "system" Apr 12 18:51:06.618852 unknown[722]: fetched user config from "qemu" Apr 12 18:51:06.619067 ignition[722]: fetch-offline: fetch-offline passed Apr 12 18:51:06.619162 systemd-resolved[200]: Detected conflict on linux IN A 10.0.0.87 Apr 12 18:51:06.620000 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' Apr 12 18:51:06.619162 ignition[722]: Ignition finished successfully Apr 12 18:51:06.619170 systemd-resolved[200]: Hostname conflict, changing published hostname from 'linux' to 'linux8'. Apr 12 18:51:06.620502 systemd[1]: Finished ignition-fetch-offline.service. Apr 12 18:51:06.621414 systemd[1]: ignition-fetch.service was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Apr 12 18:51:06.622243 systemd[1]: Starting ignition-kargs.service... Apr 12 18:51:06.640352 ignition[730]: Ignition 2.14.0 Apr 12 18:51:06.640362 ignition[730]: Stage: kargs Apr 12 18:51:06.640466 ignition[730]: no configs at "/usr/lib/ignition/base.d" Apr 12 18:51:06.640475 ignition[730]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 12 18:51:06.641314 ignition[730]: kargs: kargs passed Apr 12 18:51:06.641354 ignition[730]: Ignition finished successfully Apr 12 18:51:06.645566 systemd[1]: Finished ignition-kargs.service. Apr 12 18:51:06.646000 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' Apr 12 18:51:06.647904 systemd[1]: Starting ignition-disks.service... Apr 12 18:51:06.655160 ignition[736]: Ignition 2.14.0 Apr 12 18:51:06.655168 ignition[736]: Stage: disks Apr 12 18:51:06.655250 ignition[736]: no configs at "/usr/lib/ignition/base.d" Apr 12 18:51:06.655258 ignition[736]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 12 18:51:06.658704 ignition[736]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Apr 12 18:51:06.687526 ignition[736]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Apr 12 18:51:06.687685 ignition[736]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/vda9" Apr 12 18:51:06.696839 ignition[736]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Apr 12 18:51:06.705167 ignition[736]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Apr 12 18:51:06.705179 ignition[736]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "f68f6961-040d-4024-a760-074eede727c0" and label "ROOT" Apr 12 18:51:06.705202 ignition[736]: disks: createFilesystems: op(3): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Apr 12 18:51:06.705210 ignition[736]: disks: createFilesystems: op(3): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Apr 12 18:51:06.801330 ignition[736]: disks: createFilesystems: op(3): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Apr 12 18:51:06.801360 ignition[736]: disks: createFilesystems: op(4): [started] creating "xfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Apr 12 18:51:06.801372 ignition[736]: disks: createFilesystems: op(4): executing: "mkfs.xfs" "-L" "ROOT" "-m" "uuid=9aa5237a-ab6b-458b-a7e8-f25e2baef1a3" "-f" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Apr 12 18:51:07.326906 ignition[736]: disks: createFilesystems: op(4): [finished] creating "xfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Apr 12 18:51:07.326958 ignition[736]: disks: createFilesystems: op(5): [started] waiting for triggered uevent Apr 12 18:51:07.326965 ignition[736]: disks: createFilesystems: op(5): executing: "udevadm" "trigger" "--settle" "/dev/vda9" Apr 12 18:51:07.357937 ignition[736]: disks: createFilesystems: op(5): [finished] waiting for triggered uevent Apr 12 18:51:07.357971 ignition[736]: disks: disks passed Apr 12 18:51:07.358030 ignition[736]: Ignition finished successfully Apr 12 18:51:07.360076 systemd[1]: Finished ignition-disks.service. Apr 12 18:51:07.359000 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' Apr 12 18:51:07.361047 systemd[1]: Reached target initrd-root-device.target. Apr 12 18:51:07.362367 systemd[1]: Reached target local-fs-pre.target. Apr 12 18:51:07.365080 systemd[1]: Reached target local-fs.target. Apr 12 18:51:07.365466 systemd[1]: Reached target sysinit.target. Apr 12 18:51:07.367062 systemd[1]: Reached target basic.target. Apr 12 18:51:07.372891 systemd[1]: Starting systemd-fsck-root.service... Apr 12 18:51:07.387047 systemd-fsck[750]: /usr/sbin/fsck.xfs: XFS file system. Apr 12 18:51:07.392169 systemd[1]: Finished systemd-fsck-root.service. Apr 12 18:51:07.391000 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' Apr 12 18:51:07.393901 systemd[1]: Mounting sysroot.mount... Apr 12 18:51:07.521848 kernel: SGI XFS with ACLs, security attributes, quota, no debug enabled Apr 12 18:51:07.523821 kernel: XFS (vda9): Mounting V5 Filesystem Apr 12 18:51:07.534827 kernel: XFS (vda9): Ending clean mount Apr 12 18:51:07.536846 kernel: xfs filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Apr 12 18:51:07.537334 systemd[1]: Mounted sysroot.mount. Apr 12 18:51:07.538152 systemd[1]: Reached target initrd-root-fs.target. Apr 12 18:51:07.540416 systemd[1]: Mounting sysroot-usr.mount... Apr 12 18:51:07.541333 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Apr 12 18:51:07.541362 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 12 18:51:07.541379 systemd[1]: Reached target ignition-diskful.target. Apr 12 18:51:07.543323 systemd[1]: Mounted sysroot-usr.mount. Apr 12 18:51:07.619619 systemd[1]: Mounting sysroot-usr-share-oem.mount... Apr 12 18:51:07.626165 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (764) Apr 12 18:51:07.621393 systemd[1]: Starting initrd-setup-root.service... Apr 12 18:51:07.630625 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 12 18:51:07.630651 kernel: BTRFS info (device vda6): using free space tree Apr 12 18:51:07.630663 kernel: BTRFS info (device vda6): has skinny extents Apr 12 18:51:07.630715 initrd-setup-root[769]: cut: /sysroot/etc/passwd: No such file or directory Apr 12 18:51:07.631960 initrd-setup-root[795]: cut: /sysroot/etc/group: No such file or directory Apr 12 18:51:07.633399 systemd[1]: Mounted sysroot-usr-share-oem.mount. Apr 12 18:51:07.635165 initrd-setup-root[803]: cut: /sysroot/etc/shadow: No such file or directory Apr 12 18:51:07.638170 initrd-setup-root[811]: cut: /sysroot/etc/gshadow: No such file or directory Apr 12 18:51:07.659142 systemd[1]: Finished initrd-setup-root.service. Apr 12 18:51:07.663000 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' Apr 12 18:51:07.664967 systemd[1]: Starting ignition-mount.service... Apr 12 18:51:07.666988 systemd[1]: Starting sysroot-boot.service... Apr 12 18:51:07.670576 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. Apr 12 18:51:07.670648 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. Apr 12 18:51:07.710257 ignition[832]: INFO : Ignition 2.14.0 Apr 12 18:51:07.710257 ignition[832]: INFO : Stage: mount Apr 12 18:51:07.717000 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' Apr 12 18:51:07.711990 systemd[1]: Finished ignition-mount.service. Apr 12 18:51:07.720643 ignition[832]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 12 18:51:07.720643 ignition[832]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 12 18:51:07.720643 ignition[832]: INFO : mount: mount passed Apr 12 18:51:07.720643 ignition[832]: INFO : Ignition finished successfully Apr 12 18:51:07.719000 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' Apr 12 18:51:07.719791 systemd[1]: Finished sysroot-boot.service. Apr 12 18:51:07.721539 systemd[1]: Starting ignition-files.service... Apr 12 18:51:07.728436 systemd[1]: Mounting sysroot-usr-share-oem.mount... Apr 12 18:51:07.734657 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (839) Apr 12 18:51:07.734687 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 12 18:51:07.734710 kernel: BTRFS info (device vda6): using free space tree Apr 12 18:51:07.735453 kernel: BTRFS info (device vda6): has skinny extents Apr 12 18:51:07.739655 systemd[1]: Mounted sysroot-usr-share-oem.mount. Apr 12 18:51:07.749415 ignition[858]: INFO : Ignition 2.14.0 Apr 12 18:51:07.749415 ignition[858]: INFO : Stage: files Apr 12 18:51:07.750992 ignition[858]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 12 18:51:07.750992 ignition[858]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 12 18:51:07.753622 ignition[858]: DEBUG : files: compiled without relabeling support, skipping Apr 12 18:51:07.754911 ignition[858]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 12 18:51:07.754911 ignition[858]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 12 18:51:07.758175 ignition[858]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 12 18:51:07.759630 ignition[858]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 12 18:51:07.761193 unknown[858]: wrote ssh authorized keys file for user: core Apr 12 18:51:07.762271 ignition[858]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 12 18:51:07.774896 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 12 18:51:07.774896 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 12 18:51:07.774896 ignition[858]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Apr 12 18:51:07.774896 ignition[858]: INFO : files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 12 18:51:07.774896 ignition[858]: INFO : files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 12 18:51:07.774896 ignition[858]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Apr 12 18:51:07.774896 ignition[858]: INFO : files: createResultFile: createFiles: op(6): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 12 18:51:07.774896 ignition[858]: INFO : files: createResultFile: createFiles: op(6): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 12 18:51:07.774896 ignition[858]: INFO : files: files passed Apr 12 18:51:07.774896 ignition[858]: INFO : Ignition finished successfully Apr 12 18:51:07.779000 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' Apr 12 18:51:07.815000 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' Apr 12 18:51:07.815000 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' Apr 12 18:51:07.818000 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' Apr 12 18:51:07.777046 systemd[1]: Finished ignition-files.service. Apr 12 18:51:07.807936 systemd[1]: Starting initrd-setup-root-after-ignition.service... Apr 12 18:51:07.808336 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Apr 12 18:51:07.809282 systemd[1]: Starting ignition-quench.service... Apr 12 18:51:07.826640 initrd-setup-root-after-ignition[882]: grep: /sysroot/usr/share/oem/oem-release: No such file or directory Apr 12 18:51:07.813725 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 12 18:51:07.829210 initrd-setup-root-after-ignition[884]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 12 18:51:07.813804 systemd[1]: Finished ignition-quench.service. Apr 12 18:51:07.817947 systemd[1]: Finished initrd-setup-root-after-ignition.service. Apr 12 18:51:07.819532 systemd[1]: Reached target ignition-complete.target. Apr 12 18:51:07.821764 systemd[1]: Starting initrd-parse-etc.service... Apr 12 18:51:07.834000 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' Apr 12 18:51:07.834000 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' Apr 12 18:51:07.833824 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 12 18:51:07.833895 systemd[1]: Finished initrd-parse-etc.service. Apr 12 18:51:07.835111 systemd[1]: Reached target initrd-fs.target. Apr 12 18:51:07.835521 systemd[1]: Reached target initrd.target. Apr 12 18:51:07.835727 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Apr 12 18:51:07.836495 systemd[1]: Starting dracut-pre-pivot.service... Apr 12 18:51:07.846684 systemd[1]: Finished dracut-pre-pivot.service. Apr 12 18:51:07.846000 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' Apr 12 18:51:07.848120 systemd[1]: Starting initrd-cleanup.service... Apr 12 18:51:07.856289 systemd[1]: Stopped target nss-lookup.target. Apr 12 18:51:07.877355 systemd[1]: Stopped target remote-cryptsetup.target. Apr 12 18:51:07.878884 systemd[1]: Stopped target timers.target. Apr 12 18:51:07.880437 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 12 18:51:07.881000 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' Apr 12 18:51:07.880550 systemd[1]: Stopped dracut-pre-pivot.service. Apr 12 18:51:07.882313 systemd[1]: Stopped target initrd.target. Apr 12 18:51:07.883753 systemd[1]: Stopped target basic.target. Apr 12 18:51:07.885188 systemd[1]: Stopped target ignition-complete.target. Apr 12 18:51:07.886755 systemd[1]: Stopped target ignition-diskful.target. Apr 12 18:51:07.888280 systemd[1]: Stopped target initrd-root-device.target. Apr 12 18:51:07.889987 systemd[1]: Stopped target remote-fs.target. Apr 12 18:51:07.891597 systemd[1]: Stopped target remote-fs-pre.target. Apr 12 18:51:07.893238 systemd[1]: Stopped target sysinit.target. Apr 12 18:51:07.894723 systemd[1]: Stopped target local-fs.target. Apr 12 18:51:07.896308 systemd[1]: Stopped target local-fs-pre.target. Apr 12 18:51:07.897844 systemd[1]: Stopped target swap.target. Apr 12 18:51:07.900000 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' Apr 12 18:51:07.899256 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 12 18:51:07.899378 systemd[1]: Stopped dracut-pre-mount.service. Apr 12 18:51:07.903000 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' Apr 12 18:51:07.900946 systemd[1]: Stopped target cryptsetup.target. Apr 12 18:51:07.904000 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' Apr 12 18:51:07.902281 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 12 18:51:07.902374 systemd[1]: Stopped dracut-initqueue.service. Apr 12 18:51:07.904163 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 12 18:51:07.904255 systemd[1]: Stopped ignition-fetch-offline.service. Apr 12 18:51:07.905727 systemd[1]: Stopped target paths.target. Apr 12 18:51:07.907158 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 12 18:51:07.914000 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' Apr 12 18:51:07.908865 systemd[1]: Stopped systemd-ask-password-console.path. Apr 12 18:51:07.915000 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' Apr 12 18:51:07.909883 systemd[1]: Stopped target slices.target. Apr 12 18:51:07.919686 iscsid[707]: iscsid shutting down. Apr 12 18:51:07.911547 systemd[1]: Stopped target sockets.target. Apr 12 18:51:07.913324 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 12 18:51:07.921000 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' Apr 12 18:51:07.924000 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' Apr 12 18:51:07.913425 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Apr 12 18:51:07.915035 systemd[1]: ignition-files.service: Deactivated successfully. Apr 12 18:51:07.915118 systemd[1]: Stopped ignition-files.service. Apr 12 18:51:07.927000 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' Apr 12 18:51:07.917590 systemd[1]: Stopping ignition-mount.service... Apr 12 18:51:07.918455 systemd[1]: Stopping iscsid.service... Apr 12 18:51:07.930000 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' Apr 12 18:51:07.930000 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' Apr 12 18:51:07.931680 ignition[897]: INFO : Ignition 2.14.0 Apr 12 18:51:07.931680 ignition[897]: INFO : Stage: umount Apr 12 18:51:07.931680 ignition[897]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 12 18:51:07.931680 ignition[897]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 12 18:51:07.931680 ignition[897]: INFO : umount: umount passed Apr 12 18:51:07.931680 ignition[897]: INFO : Ignition finished successfully Apr 12 18:51:07.934000 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' Apr 12 18:51:07.935000 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' Apr 12 18:51:07.949000 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' Apr 12 18:51:07.951000 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' Apr 12 18:51:07.920297 systemd[1]: Stopping sysroot-boot.service... Apr 12 18:51:07.921120 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 12 18:51:07.921253 systemd[1]: Stopped systemd-udev-trigger.service. Apr 12 18:51:07.922823 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 12 18:51:07.922931 systemd[1]: Stopped dracut-pre-trigger.service. Apr 12 18:51:07.956000 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' Apr 12 18:51:07.926403 systemd[1]: iscsid.service: Deactivated successfully. Apr 12 18:51:07.958000 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' Apr 12 18:51:07.926482 systemd[1]: Stopped iscsid.service. Apr 12 18:51:07.928316 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 12 18:51:07.928378 systemd[1]: Finished initrd-cleanup.service. Apr 12 18:51:07.930926 systemd[1]: iscsid.socket: Deactivated successfully. Apr 12 18:51:07.930950 systemd[1]: Closed iscsid.socket. Apr 12 18:51:07.932384 systemd[1]: Stopping iscsiuio.service... Apr 12 18:51:07.933449 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 12 18:51:07.933511 systemd[1]: Stopped ignition-mount.service. Apr 12 18:51:07.934634 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 12 18:51:07.934664 systemd[1]: Stopped ignition-disks.service. Apr 12 18:51:07.936295 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 12 18:51:07.967000 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' Apr 12 18:51:07.936324 systemd[1]: Stopped ignition-kargs.service. Apr 12 18:51:07.949953 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 12 18:51:07.949983 systemd[1]: Stopped ignition-setup.service. Apr 12 18:51:07.956113 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 12 18:51:07.956208 systemd[1]: Stopped sysroot-boot.service. Apr 12 18:51:07.957371 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 12 18:51:07.957407 systemd[1]: Stopped initrd-setup-root.service. Apr 12 18:51:07.967746 systemd[1]: iscsiuio.service: Deactivated successfully. Apr 12 18:51:07.967860 systemd[1]: Stopped iscsiuio.service. Apr 12 18:51:07.968399 systemd[1]: Stopped target network.target. Apr 12 18:51:07.970521 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 12 18:51:07.970556 systemd[1]: Closed iscsiuio.socket. Apr 12 18:51:07.972002 systemd[1]: Stopping systemd-networkd.service... Apr 12 18:51:07.987000 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' Apr 12 18:51:07.972540 systemd[1]: Stopping systemd-resolved.service... Apr 12 18:51:07.986933 systemd-networkd[702]: eth0: DHCPv6 lease lost Apr 12 18:51:07.988235 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 12 18:51:07.988334 systemd[1]: Stopped systemd-resolved.service. Apr 12 18:51:07.993464 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 12 18:51:07.994000 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' Apr 12 18:51:07.993561 systemd[1]: Stopped systemd-networkd.service. Apr 12 18:51:07.996144 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 12 18:51:07.996000 audit: BPF prog-id=6 op=UNLOAD Apr 12 18:51:07.996267 systemd[1]: Closed systemd-networkd.socket. Apr 12 18:51:07.998000 audit: BPF prog-id=9 op=UNLOAD Apr 12 18:51:07.998345 systemd[1]: Stopping network-cleanup.service... Apr 12 18:51:08.000000 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' Apr 12 18:51:07.999235 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 12 18:51:08.015000 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' Apr 12 18:51:07.999287 systemd[1]: Stopped parse-ip-for-networkd.service. Apr 12 18:51:08.000861 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 12 18:51:08.021000 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' Apr 12 18:51:08.000902 systemd[1]: Stopped systemd-sysctl.service. Apr 12 18:51:08.017115 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 12 18:51:08.017179 systemd[1]: Stopped systemd-modules-load.service. Apr 12 18:51:08.023944 systemd[1]: Stopping systemd-udevd.service... Apr 12 18:51:08.029097 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 12 18:51:08.029000 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' Apr 12 18:51:08.029180 systemd[1]: Stopped network-cleanup.service. Apr 12 18:51:08.033977 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 12 18:51:08.034987 systemd[1]: Stopped systemd-udevd.service. Apr 12 18:51:08.035000 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' Apr 12 18:51:08.036857 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 12 18:51:08.036891 systemd[1]: Closed systemd-udevd-control.socket. Apr 12 18:51:08.039433 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 12 18:51:08.039462 systemd[1]: Closed systemd-udevd-kernel.socket. Apr 12 18:51:08.041983 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 12 18:51:08.042023 systemd[1]: Stopped dracut-pre-udev.service. Apr 12 18:51:08.043000 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' Apr 12 18:51:08.044583 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 12 18:51:08.044620 systemd[1]: Stopped dracut-cmdline.service. Apr 12 18:51:08.046000 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' Apr 12 18:51:08.046329 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 12 18:51:08.047070 systemd[1]: Stopped dracut-cmdline-ask.service. Apr 12 18:51:08.048000 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' Apr 12 18:51:08.050340 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Apr 12 18:51:08.052060 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 12 18:51:08.052101 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service. Apr 12 18:51:08.055000 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' Apr 12 18:51:08.055193 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 12 18:51:08.055231 systemd[1]: Stopped kmod-static-nodes.service. Apr 12 18:51:08.057000 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' Apr 12 18:51:08.058025 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 12 18:51:08.058000 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' Apr 12 18:51:08.058065 systemd[1]: Stopped systemd-vconsole-setup.service. Apr 12 18:51:08.061318 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 12 18:51:08.062477 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Apr 12 18:51:08.064000 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' Apr 12 18:51:08.064000 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' Apr 12 18:51:08.064332 systemd[1]: Reached target initrd-switch-root.target. Apr 12 18:51:08.066737 systemd[1]: Starting initrd-switch-root.service... Apr 12 18:51:08.081979 systemd[1]: Switching root. Apr 12 18:51:08.104263 systemd-journald[198]: Journal stopped Apr 12 18:51:13.520304 systemd-journald[198]: Received SIGTERM from PID 1 (n/a). Apr 12 18:51:13.520346 kernel: SELinux: Class mctp_socket not defined in policy. Apr 12 18:51:13.520361 kernel: SELinux: Class anon_inode not defined in policy. Apr 12 18:51:13.520370 kernel: SELinux: the above unknown classes and permissions will be allowed Apr 12 18:51:13.520383 kernel: SELinux: policy capability network_peer_controls=1 Apr 12 18:51:13.520396 kernel: SELinux: policy capability open_perms=1 Apr 12 18:51:13.520405 kernel: SELinux: policy capability extended_socket_class=1 Apr 12 18:51:13.520414 kernel: SELinux: policy capability always_check_network=0 Apr 12 18:51:13.520424 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 12 18:51:13.520434 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 12 18:51:13.520443 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 12 18:51:13.520452 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 12 18:51:13.520464 kernel: kauditd_printk_skb: 66 callbacks suppressed Apr 12 18:51:13.520475 kernel: audit: type=1403 audit(1712947868.213:77): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 12 18:51:13.520486 systemd[1]: Successfully loaded SELinux policy in 58.645ms. Apr 12 18:51:13.520499 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.940ms. Apr 12 18:51:13.520510 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) Apr 12 18:51:13.520520 systemd[1]: Detected virtualization kvm. Apr 12 18:51:13.520530 systemd[1]: Detected architecture x86-64. Apr 12 18:51:13.520540 systemd[1]: Detected first boot. Apr 12 18:51:13.520562 systemd[1]: Initializing machine ID from VM UUID. Apr 12 18:51:13.520575 kernel: audit: type=1400 audit(1712947868.926:78): 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 Apr 12 18:51:13.520585 kernel: audit: type=1400 audit(1712947868.926:79): 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 Apr 12 18:51:13.520594 kernel: audit: type=1334 audit(1712947868.929:80): prog-id=10 op=LOAD Apr 12 18:51:13.520603 kernel: audit: type=1334 audit(1712947868.929:81): prog-id=10 op=UNLOAD Apr 12 18:51:13.520612 kernel: audit: type=1334 audit(1712947868.933:82): prog-id=11 op=LOAD Apr 12 18:51:13.520621 kernel: audit: type=1334 audit(1712947868.933:83): prog-id=11 op=UNLOAD Apr 12 18:51:13.520630 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Apr 12 18:51:13.520642 kernel: audit: type=1400 audit(1712947868.976:84): avc: denied { associate } for pid=930 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023" Apr 12 18:51:13.520652 kernel: audit: type=1300 audit(1712947868.976:84): arch=c000003e syscall=188 success=yes exit=0 a0=c0001878f2 a1=c00002ae40 a2=c000029100 a3=32 items=0 ppid=913 pid=930 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Apr 12 18:51:13.520665 kernel: audit: type=1327 audit(1712947868.976:84): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Apr 12 18:51:13.520675 systemd[1]: Populated /etc with preset unit settings. Apr 12 18:51:13.520686 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Apr 12 18:51:13.520697 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Apr 12 18:51:13.520709 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. Apr 12 18:51:13.520719 kernel: kauditd_printk_skb: 6 callbacks suppressed Apr 12 18:51:13.520728 kernel: audit: type=1334 audit(1712947873.331:86): prog-id=12 op=LOAD Apr 12 18:51:13.520737 kernel: audit: type=1334 audit(1712947873.331:87): prog-id=3 op=UNLOAD Apr 12 18:51:13.520747 kernel: audit: type=1334 audit(1712947873.333:88): prog-id=13 op=LOAD Apr 12 18:51:13.520756 kernel: audit: type=1334 audit(1712947873.336:89): prog-id=14 op=LOAD Apr 12 18:51:13.520768 kernel: audit: type=1334 audit(1712947873.336:90): prog-id=4 op=UNLOAD Apr 12 18:51:13.520779 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 12 18:51:13.520817 kernel: audit: type=1334 audit(1712947873.336:91): prog-id=5 op=UNLOAD Apr 12 18:51:13.520833 systemd[1]: Stopped initrd-switch-root.service. Apr 12 18:51:13.520844 kernel: audit: type=1131 audit(1712947873.337:92): 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' Apr 12 18:51:13.520855 kernel: audit: type=1130 audit(1712947873.347:93): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:13.520864 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 12 18:51:13.520875 kernel: audit: type=1131 audit(1712947873.348:94): 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' Apr 12 18:51:13.520887 kernel: audit: type=1334 audit(1712947873.357:95): prog-id=12 op=UNLOAD Apr 12 18:51:13.520897 systemd[1]: Created slice system-addon\x2dconfig.slice. Apr 12 18:51:13.520908 systemd[1]: Created slice system-addon\x2drun.slice. Apr 12 18:51:13.520918 systemd[1]: Created slice system-getty.slice. Apr 12 18:51:13.520928 systemd[1]: Created slice system-modprobe.slice. Apr 12 18:51:13.520938 systemd[1]: Created slice system-serial\x2dgetty.slice. Apr 12 18:51:13.520949 systemd[1]: Created slice system-system\x2dcloudinit.slice. Apr 12 18:51:13.520959 systemd[1]: Created slice system-systemd\x2dfsck.slice. Apr 12 18:51:13.520968 systemd[1]: Created slice user.slice. Apr 12 18:51:13.520979 systemd[1]: Started systemd-ask-password-console.path. Apr 12 18:51:13.520989 systemd[1]: Started systemd-ask-password-wall.path. Apr 12 18:51:13.521000 systemd[1]: Set up automount boot.automount. Apr 12 18:51:13.521009 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Apr 12 18:51:13.521019 systemd[1]: Stopped target initrd-switch-root.target. Apr 12 18:51:13.521029 systemd[1]: Stopped target initrd-fs.target. Apr 12 18:51:13.521040 systemd[1]: Stopped target initrd-root-fs.target. Apr 12 18:51:13.521049 systemd[1]: Reached target integritysetup.target. Apr 12 18:51:13.521060 systemd[1]: Reached target remote-cryptsetup.target. Apr 12 18:51:13.521073 systemd[1]: Reached target remote-fs.target. Apr 12 18:51:13.521082 systemd[1]: Reached target slices.target. Apr 12 18:51:13.521092 systemd[1]: Reached target swap.target. Apr 12 18:51:13.521102 systemd[1]: Reached target torcx.target. Apr 12 18:51:13.521112 systemd[1]: Reached target veritysetup.target. Apr 12 18:51:13.521122 systemd[1]: Listening on systemd-coredump.socket. Apr 12 18:51:13.521132 systemd[1]: Listening on systemd-initctl.socket. Apr 12 18:51:13.521142 systemd[1]: Listening on systemd-networkd.socket. Apr 12 18:51:13.521153 systemd[1]: Listening on systemd-udevd-control.socket. Apr 12 18:51:13.521163 systemd[1]: Listening on systemd-udevd-kernel.socket. Apr 12 18:51:13.521173 systemd[1]: Listening on systemd-userdbd.socket. Apr 12 18:51:13.521183 systemd[1]: Mounting dev-hugepages.mount... Apr 12 18:51:13.521193 systemd[1]: Mounting dev-mqueue.mount... Apr 12 18:51:13.521203 systemd[1]: Mounting media.mount... Apr 12 18:51:13.521213 systemd[1]: proc-xen.mount was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 12 18:51:13.521223 systemd[1]: Mounting sys-kernel-debug.mount... Apr 12 18:51:13.521234 systemd[1]: Mounting sys-kernel-tracing.mount... Apr 12 18:51:13.521244 systemd[1]: Mounting tmp.mount... Apr 12 18:51:13.521254 systemd[1]: Starting flatcar-tmpfiles.service... Apr 12 18:51:13.521264 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Apr 12 18:51:13.521275 systemd[1]: Starting kmod-static-nodes.service... Apr 12 18:51:13.521285 systemd[1]: Starting modprobe@configfs.service... Apr 12 18:51:13.521295 systemd[1]: Starting modprobe@dm_mod.service... Apr 12 18:51:13.521305 systemd[1]: Starting modprobe@drm.service... Apr 12 18:51:13.521315 systemd[1]: Starting modprobe@efi_pstore.service... Apr 12 18:51:13.521326 systemd[1]: Starting modprobe@fuse.service... Apr 12 18:51:13.521336 systemd[1]: Starting modprobe@loop.service... Apr 12 18:51:13.521346 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 12 18:51:13.521356 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 12 18:51:13.521366 systemd[1]: Stopped systemd-fsck-root.service. Apr 12 18:51:13.521375 kernel: loop: module loaded Apr 12 18:51:13.521385 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 12 18:51:13.521395 systemd[1]: Stopped systemd-fsck-usr.service. Apr 12 18:51:13.521405 systemd[1]: Stopped systemd-journald.service. Apr 12 18:51:13.521416 systemd[1]: Starting systemd-journald.service... Apr 12 18:51:13.521426 kernel: fuse: init (API version 7.34) Apr 12 18:51:13.521435 systemd[1]: Starting systemd-modules-load.service... Apr 12 18:51:13.521445 systemd[1]: Starting systemd-network-generator.service... Apr 12 18:51:13.521455 systemd[1]: Starting systemd-remount-fs.service... Apr 12 18:51:13.521465 systemd[1]: Starting systemd-udev-trigger.service... Apr 12 18:51:13.521475 systemd[1]: verity-setup.service: Deactivated successfully. Apr 12 18:51:13.521485 systemd[1]: Stopped verity-setup.service. Apr 12 18:51:13.521496 systemd[1]: xenserver-pv-version.service was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 12 18:51:13.521509 systemd-journald[1019]: Journal started Apr 12 18:51:13.521563 systemd-journald[1019]: Runtime Journal (/run/log/journal/f7b4ac0ff1c7487e8b4dff6e1f05a733) is 6.0M, max 48.5M, 42.5M free. Apr 12 18:51:08.213000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 12 18:51:08.926000 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 Apr 12 18:51:08.926000 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 Apr 12 18:51:08.929000 audit: BPF prog-id=10 op=LOAD Apr 12 18:51:08.929000 audit: BPF prog-id=10 op=UNLOAD Apr 12 18:51:08.933000 audit: BPF prog-id=11 op=LOAD Apr 12 18:51:08.933000 audit: BPF prog-id=11 op=UNLOAD Apr 12 18:51:08.976000 audit[930]: AVC avc: denied { associate } for pid=930 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023" Apr 12 18:51:08.976000 audit[930]: SYSCALL arch=c000003e syscall=188 success=yes exit=0 a0=c0001878f2 a1=c00002ae40 a2=c000029100 a3=32 items=0 ppid=913 pid=930 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Apr 12 18:51:08.976000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Apr 12 18:51:08.978000 audit[930]: AVC avc: denied { associate } for pid=930 comm="torcx-generator" name="usr" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Apr 12 18:51:08.978000 audit[930]: SYSCALL arch=c000003e syscall=258 success=yes exit=0 a0=ffffffffffffff9c a1=c0001879c9 a2=1ed a3=0 items=2 ppid=913 pid=930 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Apr 12 18:51:08.978000 audit: CWD cwd="/" Apr 12 18:51:08.978000 audit: PATH item=0 name=(null) inode=2 dev=00:1b mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Apr 12 18:51:08.978000 audit: PATH item=1 name=(null) inode=3 dev=00:1b mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Apr 12 18:51:08.978000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Apr 12 18:51:13.331000 audit: BPF prog-id=12 op=LOAD Apr 12 18:51:13.331000 audit: BPF prog-id=3 op=UNLOAD Apr 12 18:51:13.333000 audit: BPF prog-id=13 op=LOAD Apr 12 18:51:13.336000 audit: BPF prog-id=14 op=LOAD Apr 12 18:51:13.336000 audit: BPF prog-id=4 op=UNLOAD Apr 12 18:51:13.336000 audit: BPF prog-id=5 op=UNLOAD Apr 12 18:51:13.337000 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' Apr 12 18:51:13.347000 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' Apr 12 18:51:13.348000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:13.357000 audit: BPF prog-id=12 op=UNLOAD Apr 12 18:51:13.488000 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' Apr 12 18:51:13.491000 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' Apr 12 18:51:13.493000 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' Apr 12 18:51:13.493000 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' Apr 12 18:51:13.495000 audit: BPF prog-id=15 op=LOAD Apr 12 18:51:13.495000 audit: BPF prog-id=16 op=LOAD Apr 12 18:51:13.495000 audit: BPF prog-id=17 op=LOAD Apr 12 18:51:13.495000 audit: BPF prog-id=13 op=UNLOAD Apr 12 18:51:13.495000 audit: BPF prog-id=14 op=UNLOAD Apr 12 18:51:13.517000 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' Apr 12 18:51:13.517000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Apr 12 18:51:13.517000 audit[1019]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=5 a1=7fff3f3e7940 a2=4000 a3=7fff3f3e79dc items=0 ppid=1 pid=1019 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) Apr 12 18:51:13.517000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Apr 12 18:51:13.329656 systemd[1]: Queued start job for default target multi-user.target. Apr 12 18:51:08.974921 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" 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.3 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.3 /var/lib/torcx/store]" Apr 12 18:51:13.329671 systemd[1]: Unnecessary job was removed for dev-vda6.device. Apr 12 18:51:08.975242 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Apr 12 18:51:13.338295 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 12 18:51:08.975260 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Apr 12 18:51:08.975292 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Apr 12 18:51:08.975302 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=debug msg="skipped missing lower profile" missing profile=oem Apr 12 18:51:08.975330 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Apr 12 18:51:08.975342 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Apr 12 18:51:08.975544 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Apr 12 18:51:08.975574 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Apr 12 18:51:08.975585 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Apr 12 18:51:08.976824 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" 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 Apr 12 18:51:08.976870 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" 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 Apr 12 18:51:08.976895 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.3: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.3 Apr 12 18:51:08.976914 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Apr 12 18:51:08.976936 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.3: no such file or directory" path=/var/lib/torcx/store/3510.3.3 Apr 12 18:51:08.976954 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:08Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Apr 12 18:51:12.966207 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:12Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Apr 12 18:51:12.966548 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:12Z" 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 Apr 12 18:51:12.966772 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:12Z" 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 Apr 12 18:51:12.967015 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:12Z" 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 Apr 12 18:51:12.967072 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:12Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Apr 12 18:51:12.967154 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2024-04-12T18:51:12Z" 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 Apr 12 18:51:13.524953 systemd[1]: Started systemd-journald.service. Apr 12 18:51:13.524000 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' Apr 12 18:51:13.526045 systemd[1]: Mounted dev-hugepages.mount. Apr 12 18:51:13.527130 systemd[1]: Mounted dev-mqueue.mount. Apr 12 18:51:13.528155 systemd[1]: Mounted media.mount. Apr 12 18:51:13.529250 systemd[1]: Mounted sys-kernel-debug.mount. Apr 12 18:51:13.530389 systemd[1]: Mounted sys-kernel-tracing.mount. Apr 12 18:51:13.531578 systemd[1]: Mounted tmp.mount. Apr 12 18:51:13.532868 systemd[1]: Finished flatcar-tmpfiles.service. Apr 12 18:51:13.533000 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' Apr 12 18:51:13.534315 systemd[1]: Finished kmod-static-nodes.service. Apr 12 18:51:13.534000 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' Apr 12 18:51:13.535688 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 12 18:51:13.535932 systemd[1]: Finished modprobe@configfs.service. Apr 12 18:51:13.536000 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' Apr 12 18:51:13.536000 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' Apr 12 18:51:13.537323 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 12 18:51:13.537534 systemd[1]: Finished modprobe@dm_mod.service. Apr 12 18:51:13.537000 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' Apr 12 18:51:13.537000 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' Apr 12 18:51:13.538927 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 12 18:51:13.539143 systemd[1]: Finished modprobe@drm.service. Apr 12 18:51:13.539000 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' Apr 12 18:51:13.539000 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' Apr 12 18:51:13.540443 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 12 18:51:13.540661 systemd[1]: Finished modprobe@efi_pstore.service. Apr 12 18:51:13.540000 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' Apr 12 18:51:13.540000 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' Apr 12 18:51:13.542046 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 12 18:51:13.542350 systemd[1]: Finished modprobe@fuse.service. Apr 12 18:51:13.542000 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' Apr 12 18:51:13.542000 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' Apr 12 18:51:13.543612 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 12 18:51:13.543842 systemd[1]: Finished modprobe@loop.service. Apr 12 18:51:13.544000 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' Apr 12 18:51:13.544000 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' Apr 12 18:51:13.545296 systemd[1]: Finished systemd-modules-load.service. Apr 12 18:51:13.545000 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' Apr 12 18:51:13.546924 systemd[1]: Finished systemd-network-generator.service. Apr 12 18:51:13.547000 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' Apr 12 18:51:13.548418 systemd[1]: Finished systemd-remount-fs.service. Apr 12 18:51:13.548000 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' Apr 12 18:51:13.550084 systemd[1]: Reached target network-pre.target. Apr 12 18:51:13.552644 systemd[1]: Mounting sys-fs-fuse-connections.mount... Apr 12 18:51:13.555040 systemd[1]: Mounting sys-kernel-config.mount... Apr 12 18:51:13.556042 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 12 18:51:13.558095 systemd[1]: Starting systemd-hwdb-update.service... Apr 12 18:51:13.560280 systemd[1]: Starting systemd-journal-flush.service... Apr 12 18:51:13.561343 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 12 18:51:13.563246 systemd[1]: Starting systemd-random-seed.service... Apr 12 18:51:13.564277 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Apr 12 18:51:13.566048 systemd[1]: Starting systemd-sysctl.service... Apr 12 18:51:13.568095 systemd[1]: Starting systemd-sysusers.service... Apr 12 18:51:13.570475 systemd[1]: Mounted sys-fs-fuse-connections.mount. Apr 12 18:51:13.573000 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' Apr 12 18:51:13.581100 systemd-journald[1019]: Runtime Journal (/run/log/journal/f7b4ac0ff1c7487e8b4dff6e1f05a733) is 6.0M, max 48.5M, 42.5M free. Apr 12 18:51:13.582977 systemd-journald[1019]: Received client request to flush runtime journal. Apr 12 18:51:13.572446 systemd[1]: Mounted sys-kernel-config.mount. Apr 12 18:51:13.575136 systemd[1]: Finished systemd-random-seed.service. Apr 12 18:51:13.576304 systemd[1]: Reached target first-boot-complete.target. Apr 12 18:51:13.586851 systemd[1]: Finished systemd-journal-flush.service. Apr 12 18:51:13.587000 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' Apr 12 18:51:13.591267 systemd[1]: Finished systemd-sysctl.service. Apr 12 18:51:13.591000 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' Apr 12 18:51:13.595384 systemd[1]: Finished systemd-sysusers.service. Apr 12 18:51:13.595000 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' Apr 12 18:51:13.597897 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Apr 12 18:51:13.621079 systemd[1]: Finished systemd-udev-trigger.service. Apr 12 18:51:13.621000 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' Apr 12 18:51:13.622610 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Apr 12 18:51:13.623000 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' Apr 12 18:51:13.625149 systemd[1]: Starting systemd-udev-settle.service... Apr 12 18:51:13.632679 udevadm[1038]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Apr 12 18:51:14.273548 systemd[1]: Finished systemd-hwdb-update.service. Apr 12 18:51:14.273000 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' Apr 12 18:51:14.274000 audit: BPF prog-id=18 op=LOAD Apr 12 18:51:14.274000 audit: BPF prog-id=19 op=LOAD Apr 12 18:51:14.274000 audit: BPF prog-id=7 op=UNLOAD Apr 12 18:51:14.274000 audit: BPF prog-id=8 op=UNLOAD Apr 12 18:51:14.276430 systemd[1]: Starting systemd-udevd.service... Apr 12 18:51:14.298072 systemd-udevd[1039]: Using default interface naming scheme 'v252'. Apr 12 18:51:14.316470 systemd[1]: Started systemd-udevd.service. Apr 12 18:51:14.316000 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' Apr 12 18:51:14.320000 audit: BPF prog-id=20 op=LOAD Apr 12 18:51:14.321656 systemd[1]: Starting systemd-networkd.service... Apr 12 18:51:14.328000 audit: BPF prog-id=21 op=LOAD Apr 12 18:51:14.328000 audit: BPF prog-id=22 op=LOAD Apr 12 18:51:14.328000 audit: BPF prog-id=23 op=LOAD Apr 12 18:51:14.329973 systemd[1]: Starting systemd-userdbd.service... Apr 12 18:51:14.347483 systemd[1]: Condition check resulted in dev-ttyS0.device being skipped. Apr 12 18:51:14.370000 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' Apr 12 18:51:14.369967 systemd[1]: Started systemd-userdbd.service. Apr 12 18:51:14.386545 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Apr 12 18:51:14.415834 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Apr 12 18:51:14.426651 systemd-networkd[1047]: lo: Link UP Apr 12 18:51:14.426661 systemd-networkd[1047]: lo: Gained carrier Apr 12 18:51:14.427111 systemd-networkd[1047]: Enumeration completed Apr 12 18:51:14.427220 systemd[1]: Started systemd-networkd.service. Apr 12 18:51:14.427272 systemd-networkd[1047]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 12 18:51:14.427000 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' Apr 12 18:51:14.429234 systemd-networkd[1047]: eth0: Link UP Apr 12 18:51:14.429240 systemd-networkd[1047]: eth0: Gained carrier Apr 12 18:51:14.431124 kernel: ACPI: button: Power Button [PWRF] Apr 12 18:51:14.422000 audit[1044]: AVC avc: denied { confidentiality } for pid=1044 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 Apr 12 18:51:14.445050 systemd-networkd[1047]: eth0: DHCPv4 address 10.0.0.87/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 12 18:51:14.422000 audit[1044]: SYSCALL arch=c000003e syscall=175 success=yes exit=0 a0=55d234c91d90 a1=32194 a2=7f775a72fbc5 a3=5 items=108 ppid=1039 pid=1044 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) Apr 12 18:51:14.422000 audit: CWD cwd="/" Apr 12 18:51:14.422000 audit: PATH item=0 name=(null) inode=1041 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 Apr 12 18:51:14.422000 audit: PATH item=1 name=(null) inode=14809 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 Apr 12 18:51:14.422000 audit: PATH item=2 name=(null) inode=14809 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 Apr 12 18:51:14.422000 audit: PATH item=3 name=(null) inode=14810 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 Apr 12 18:51:14.422000 audit: PATH item=4 name=(null) inode=14809 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 Apr 12 18:51:14.422000 audit: PATH item=5 name=(null) inode=14811 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 Apr 12 18:51:14.422000 audit: PATH item=6 name=(null) inode=14809 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 Apr 12 18:51:14.422000 audit: PATH item=7 name=(null) inode=14812 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 Apr 12 18:51:14.422000 audit: PATH item=8 name=(null) inode=14812 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 Apr 12 18:51:14.453841 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 Apr 12 18:51:14.422000 audit: PATH item=9 name=(null) inode=14813 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 Apr 12 18:51:14.422000 audit: PATH item=10 name=(null) inode=14812 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 Apr 12 18:51:14.422000 audit: PATH item=11 name=(null) inode=14814 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 Apr 12 18:51:14.422000 audit: PATH item=12 name=(null) inode=14812 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 Apr 12 18:51:14.422000 audit: PATH item=13 name=(null) inode=14815 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 Apr 12 18:51:14.422000 audit: PATH item=14 name=(null) inode=14812 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 Apr 12 18:51:14.422000 audit: PATH item=15 name=(null) inode=14816 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 Apr 12 18:51:14.422000 audit: PATH item=16 name=(null) inode=14812 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 Apr 12 18:51:14.422000 audit: PATH item=17 name=(null) inode=14817 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 Apr 12 18:51:14.422000 audit: PATH item=18 name=(null) inode=14809 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 Apr 12 18:51:14.422000 audit: PATH item=19 name=(null) inode=14818 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 Apr 12 18:51:14.422000 audit: PATH item=20 name=(null) inode=14818 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 Apr 12 18:51:14.422000 audit: PATH item=21 name=(null) inode=14819 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 Apr 12 18:51:14.422000 audit: PATH item=22 name=(null) inode=14818 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 Apr 12 18:51:14.422000 audit: PATH item=23 name=(null) inode=14820 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 Apr 12 18:51:14.422000 audit: PATH item=24 name=(null) inode=14818 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 Apr 12 18:51:14.422000 audit: PATH item=25 name=(null) inode=14821 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 Apr 12 18:51:14.422000 audit: PATH item=26 name=(null) inode=14818 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 Apr 12 18:51:14.422000 audit: PATH item=27 name=(null) inode=14822 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 Apr 12 18:51:14.422000 audit: PATH item=28 name=(null) inode=14818 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 Apr 12 18:51:14.422000 audit: PATH item=29 name=(null) inode=14823 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 Apr 12 18:51:14.422000 audit: PATH item=30 name=(null) inode=14809 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 Apr 12 18:51:14.422000 audit: PATH item=31 name=(null) inode=14824 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 Apr 12 18:51:14.422000 audit: PATH item=32 name=(null) inode=14824 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 Apr 12 18:51:14.422000 audit: PATH item=33 name=(null) inode=14825 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 Apr 12 18:51:14.422000 audit: PATH item=34 name=(null) inode=14824 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 Apr 12 18:51:14.422000 audit: PATH item=35 name=(null) inode=14826 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 Apr 12 18:51:14.422000 audit: PATH item=36 name=(null) inode=14824 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 Apr 12 18:51:14.422000 audit: PATH item=37 name=(null) inode=14827 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 Apr 12 18:51:14.422000 audit: PATH item=38 name=(null) inode=14824 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 Apr 12 18:51:14.422000 audit: PATH item=39 name=(null) inode=14828 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 Apr 12 18:51:14.422000 audit: PATH item=40 name=(null) inode=14824 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 Apr 12 18:51:14.422000 audit: PATH item=41 name=(null) inode=14829 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 Apr 12 18:51:14.422000 audit: PATH item=42 name=(null) inode=14809 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 Apr 12 18:51:14.422000 audit: PATH item=43 name=(null) inode=14830 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 Apr 12 18:51:14.422000 audit: PATH item=44 name=(null) inode=14830 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 Apr 12 18:51:14.422000 audit: PATH item=45 name=(null) inode=14831 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 Apr 12 18:51:14.422000 audit: PATH item=46 name=(null) inode=14830 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 Apr 12 18:51:14.422000 audit: PATH item=47 name=(null) inode=14832 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 Apr 12 18:51:14.422000 audit: PATH item=48 name=(null) inode=14830 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 Apr 12 18:51:14.422000 audit: PATH item=49 name=(null) inode=14833 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 Apr 12 18:51:14.422000 audit: PATH item=50 name=(null) inode=14830 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 Apr 12 18:51:14.422000 audit: PATH item=51 name=(null) inode=14834 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 Apr 12 18:51:14.422000 audit: PATH item=52 name=(null) inode=14830 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 Apr 12 18:51:14.422000 audit: PATH item=53 name=(null) inode=14835 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 Apr 12 18:51:14.422000 audit: PATH item=54 name=(null) inode=1041 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 Apr 12 18:51:14.422000 audit: PATH item=55 name=(null) inode=14836 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 Apr 12 18:51:14.422000 audit: PATH item=56 name=(null) inode=14836 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 Apr 12 18:51:14.422000 audit: PATH item=57 name=(null) inode=14837 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 Apr 12 18:51:14.422000 audit: PATH item=58 name=(null) inode=14836 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 Apr 12 18:51:14.422000 audit: PATH item=59 name=(null) inode=14838 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 Apr 12 18:51:14.422000 audit: PATH item=60 name=(null) inode=14836 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 Apr 12 18:51:14.422000 audit: PATH item=61 name=(null) inode=14839 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 Apr 12 18:51:14.422000 audit: PATH item=62 name=(null) inode=14839 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 Apr 12 18:51:14.422000 audit: PATH item=63 name=(null) inode=14840 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 Apr 12 18:51:14.422000 audit: PATH item=64 name=(null) inode=14839 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 Apr 12 18:51:14.422000 audit: PATH item=65 name=(null) inode=14841 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 Apr 12 18:51:14.422000 audit: PATH item=66 name=(null) inode=14839 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 Apr 12 18:51:14.422000 audit: PATH item=67 name=(null) inode=14842 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 Apr 12 18:51:14.422000 audit: PATH item=68 name=(null) inode=14839 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 Apr 12 18:51:14.422000 audit: PATH item=69 name=(null) inode=14843 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 Apr 12 18:51:14.422000 audit: PATH item=70 name=(null) inode=14839 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 Apr 12 18:51:14.422000 audit: PATH item=71 name=(null) inode=14844 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 Apr 12 18:51:14.422000 audit: PATH item=72 name=(null) inode=14836 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 Apr 12 18:51:14.422000 audit: PATH item=73 name=(null) inode=14845 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 Apr 12 18:51:14.422000 audit: PATH item=74 name=(null) inode=14845 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 Apr 12 18:51:14.422000 audit: PATH item=75 name=(null) inode=14846 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 Apr 12 18:51:14.422000 audit: PATH item=76 name=(null) inode=14845 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 Apr 12 18:51:14.422000 audit: PATH item=77 name=(null) inode=14847 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 Apr 12 18:51:14.422000 audit: PATH item=78 name=(null) inode=14845 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 Apr 12 18:51:14.422000 audit: PATH item=79 name=(null) inode=14848 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 Apr 12 18:51:14.422000 audit: PATH item=80 name=(null) inode=14845 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 Apr 12 18:51:14.422000 audit: PATH item=81 name=(null) inode=14849 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 Apr 12 18:51:14.422000 audit: PATH item=82 name=(null) inode=14845 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 Apr 12 18:51:14.422000 audit: PATH item=83 name=(null) inode=14850 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 Apr 12 18:51:14.422000 audit: PATH item=84 name=(null) inode=14836 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 Apr 12 18:51:14.422000 audit: PATH item=85 name=(null) inode=14851 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 Apr 12 18:51:14.422000 audit: PATH item=86 name=(null) inode=14851 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 Apr 12 18:51:14.422000 audit: PATH item=87 name=(null) inode=14852 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 Apr 12 18:51:14.422000 audit: PATH item=88 name=(null) inode=14851 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 Apr 12 18:51:14.422000 audit: PATH item=89 name=(null) inode=14853 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 Apr 12 18:51:14.422000 audit: PATH item=90 name=(null) inode=14851 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 Apr 12 18:51:14.422000 audit: PATH item=91 name=(null) inode=14854 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 Apr 12 18:51:14.422000 audit: PATH item=92 name=(null) inode=14851 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 Apr 12 18:51:14.422000 audit: PATH item=93 name=(null) inode=14855 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 Apr 12 18:51:14.422000 audit: PATH item=94 name=(null) inode=14851 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 Apr 12 18:51:14.422000 audit: PATH item=95 name=(null) inode=14856 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 Apr 12 18:51:14.422000 audit: PATH item=96 name=(null) inode=14836 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 Apr 12 18:51:14.422000 audit: PATH item=97 name=(null) inode=14857 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 Apr 12 18:51:14.422000 audit: PATH item=98 name=(null) inode=14857 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 Apr 12 18:51:14.422000 audit: PATH item=99 name=(null) inode=14858 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 Apr 12 18:51:14.422000 audit: PATH item=100 name=(null) inode=14857 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 Apr 12 18:51:14.422000 audit: PATH item=101 name=(null) inode=14859 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 Apr 12 18:51:14.422000 audit: PATH item=102 name=(null) inode=14857 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 Apr 12 18:51:14.422000 audit: PATH item=103 name=(null) inode=14860 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 Apr 12 18:51:14.422000 audit: PATH item=104 name=(null) inode=14857 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 Apr 12 18:51:14.422000 audit: PATH item=105 name=(null) inode=14861 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 Apr 12 18:51:14.422000 audit: PATH item=106 name=(null) inode=14857 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 Apr 12 18:51:14.422000 audit: PATH item=107 name=(null) inode=14862 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 Apr 12 18:51:14.422000 audit: PROCTITLE proctitle="(udev-worker)" Apr 12 18:51:14.477828 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Apr 12 18:51:14.494839 kernel: mousedev: PS/2 mouse device common for all mice Apr 12 18:51:14.514878 kernel: kvm: Nested Virtualization enabled Apr 12 18:51:14.515093 kernel: SVM: kvm: Nested Paging enabled Apr 12 18:51:14.515148 kernel: SVM: Virtual VMLOAD VMSAVE supported Apr 12 18:51:14.515192 kernel: SVM: Virtual GIF supported Apr 12 18:51:14.569578 kernel: EDAC MC: Ver: 3.0.0 Apr 12 18:51:14.611430 systemd[1]: Finished systemd-udev-settle.service. Apr 12 18:51:14.611000 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' Apr 12 18:51:14.614428 systemd[1]: Starting lvm2-activation-early.service... Apr 12 18:51:14.631464 lvm[1074]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 12 18:51:14.668206 systemd[1]: Finished lvm2-activation-early.service. Apr 12 18:51:14.669650 systemd[1]: Reached target cryptsetup.target. Apr 12 18:51:14.668000 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' Apr 12 18:51:14.671874 systemd[1]: Starting lvm2-activation.service... Apr 12 18:51:14.676396 lvm[1075]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 12 18:51:14.705193 systemd[1]: Finished lvm2-activation.service. Apr 12 18:51:14.705000 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' Apr 12 18:51:14.707328 systemd[1]: Reached target local-fs-pre.target. Apr 12 18:51:14.708509 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Apr 12 18:51:14.708550 systemd[1]: Reached target local-fs.target. Apr 12 18:51:14.709535 systemd[1]: Reached target machines.target. Apr 12 18:51:14.712010 systemd[1]: Starting ldconfig.service... Apr 12 18:51:14.713200 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Apr 12 18:51:14.713242 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). Apr 12 18:51:14.714379 systemd[1]: Starting systemd-boot-update.service... Apr 12 18:51:14.717020 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Apr 12 18:51:14.719239 systemd[1]: Starting systemd-machine-id-commit.service... Apr 12 18:51:14.720320 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Apr 12 18:51:14.720354 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Apr 12 18:51:14.721939 systemd[1]: Starting systemd-tmpfiles-setup.service... Apr 12 18:51:14.723661 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1077 (bootctl) Apr 12 18:51:14.725048 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Apr 12 18:51:14.728380 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Apr 12 18:51:14.729000 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' Apr 12 18:51:14.730578 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 12 18:51:14.731068 systemd[1]: Finished systemd-machine-id-commit.service. Apr 12 18:51:14.731000 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' Apr 12 18:51:14.737752 systemd-tmpfiles[1080]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Apr 12 18:51:14.738462 systemd-tmpfiles[1080]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 12 18:51:14.741989 systemd-tmpfiles[1080]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 12 18:51:14.772750 systemd-fsck[1085]: fsck.fat 4.2 (2021-01-31) Apr 12 18:51:14.772750 systemd-fsck[1085]: /dev/vda1: 789 files, 119240/258078 clusters Apr 12 18:51:14.774538 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Apr 12 18:51:14.775000 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' Apr 12 18:51:14.778241 systemd[1]: Mounting boot.mount... Apr 12 18:51:14.787557 systemd[1]: Mounted boot.mount. Apr 12 18:51:14.804191 systemd[1]: Finished systemd-boot-update.service. Apr 12 18:51:14.805000 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' Apr 12 18:51:14.864124 ldconfig[1076]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 12 18:51:14.870179 systemd[1]: Finished ldconfig.service. Apr 12 18:51:14.870000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=ldconfig comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:14.871269 systemd[1]: Finished systemd-tmpfiles-setup.service. Apr 12 18:51:14.871000 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' Apr 12 18:51:14.873390 systemd[1]: Starting audit-rules.service... Apr 12 18:51:14.874949 systemd[1]: Starting clean-ca-certificates.service... Apr 12 18:51:14.877000 audit: BPF prog-id=24 op=LOAD Apr 12 18:51:14.876757 systemd[1]: Starting systemd-journal-catalog-update.service... Apr 12 18:51:14.879161 systemd[1]: Starting systemd-resolved.service... Apr 12 18:51:14.880000 audit: BPF prog-id=25 op=LOAD Apr 12 18:51:14.882936 systemd[1]: Starting systemd-timesyncd.service... Apr 12 18:51:14.885954 systemd[1]: Starting systemd-update-utmp.service... Apr 12 18:51:14.887277 systemd[1]: Finished clean-ca-certificates.service. Apr 12 18:51:14.887000 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' Apr 12 18:51:14.888464 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Apr 12 18:51:14.890000 audit[1099]: SYSTEM_BOOT pid=1099 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' Apr 12 18:51:14.894401 systemd[1]: Finished systemd-update-utmp.service. Apr 12 18:51:14.894000 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' Apr 12 18:51:14.898045 systemd[1]: Finished systemd-journal-catalog-update.service. Apr 12 18:51:14.898000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:14.900332 systemd[1]: Starting systemd-update-done.service... Apr 12 18:51:14.906200 systemd[1]: Finished systemd-update-done.service. Apr 12 18:51:14.906000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-done comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:14.909000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Apr 12 18:51:14.909000 audit[1110]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffef096b170 a2=420 a3=0 items=0 ppid=1088 pid=1110 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) Apr 12 18:51:14.909000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Apr 12 18:51:14.911072 augenrules[1110]: No rules Apr 12 18:51:14.911881 systemd[1]: Finished audit-rules.service. Apr 12 18:51:14.933308 systemd[1]: Started systemd-timesyncd.service. Apr 12 18:51:14.934399 systemd[1]: Reached target time-set.target. Apr 12 18:51:15.804457 systemd-timesyncd[1098]: Contacted time server 10.0.0.1:123 (10.0.0.1). Apr 12 18:51:15.804490 systemd-timesyncd[1098]: Initial clock synchronization to Fri 2024-04-12 18:51:15.804400 UTC. Apr 12 18:51:15.822785 systemd-resolved[1092]: Positive Trust Anchors: Apr 12 18:51:15.822806 systemd-resolved[1092]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 12 18:51:15.822842 systemd-resolved[1092]: 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 Apr 12 18:51:15.833818 systemd-resolved[1092]: Defaulting to hostname 'linux'. Apr 12 18:51:15.835709 systemd[1]: Started systemd-resolved.service. Apr 12 18:51:15.836710 systemd[1]: Reached target network.target. Apr 12 18:51:15.837523 systemd[1]: Reached target nss-lookup.target. Apr 12 18:51:15.838375 systemd[1]: Reached target sysinit.target. Apr 12 18:51:15.839230 systemd[1]: Started motdgen.path. Apr 12 18:51:15.839973 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Apr 12 18:51:15.841202 systemd[1]: Started logrotate.timer. Apr 12 18:51:15.842059 systemd[1]: Started mdadm.timer. Apr 12 18:51:15.842775 systemd[1]: Started systemd-tmpfiles-clean.timer. Apr 12 18:51:15.843653 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 12 18:51:15.843682 systemd[1]: Reached target paths.target. Apr 12 18:51:15.844473 systemd[1]: Reached target timers.target. Apr 12 18:51:15.845638 systemd[1]: Listening on dbus.socket. Apr 12 18:51:15.847411 systemd[1]: Starting docker.socket... Apr 12 18:51:15.850486 systemd[1]: Listening on sshd.socket. Apr 12 18:51:15.851356 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). Apr 12 18:51:15.851688 systemd[1]: Listening on docker.socket. Apr 12 18:51:15.852541 systemd[1]: Reached target sockets.target. Apr 12 18:51:15.853348 systemd[1]: Reached target basic.target. Apr 12 18:51:15.854154 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Apr 12 18:51:15.854174 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Apr 12 18:51:15.855088 systemd[1]: Starting containerd.service... Apr 12 18:51:15.856743 systemd[1]: Starting dbus.service... Apr 12 18:51:15.858632 systemd[1]: Starting enable-oem-cloudinit.service... Apr 12 18:51:15.860879 systemd[1]: Starting extend-filesystems.service... Apr 12 18:51:15.862033 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Apr 12 18:51:15.863153 jq[1120]: false Apr 12 18:51:15.863424 systemd[1]: Starting motdgen.service... Apr 12 18:51:15.865957 systemd[1]: Starting ssh-key-proc-cmdline.service... Apr 12 18:51:15.868474 systemd[1]: Starting sshd-keygen.service... Apr 12 18:51:15.876124 systemd[1]: Starting systemd-logind.service... Apr 12 18:51:15.877482 extend-filesystems[1121]: Found sr0 Apr 12 18:51:15.877482 extend-filesystems[1121]: Found vda Apr 12 18:51:15.877482 extend-filesystems[1121]: Found vda1 Apr 12 18:51:15.877482 extend-filesystems[1121]: Found vda2 Apr 12 18:51:15.877482 extend-filesystems[1121]: Found vda3 Apr 12 18:51:15.877482 extend-filesystems[1121]: Found usr Apr 12 18:51:15.877482 extend-filesystems[1121]: Found vda4 Apr 12 18:51:15.877482 extend-filesystems[1121]: Found vda6 Apr 12 18:51:15.877482 extend-filesystems[1121]: Found vda7 Apr 12 18:51:15.877482 extend-filesystems[1121]: Found vda9 Apr 12 18:51:15.877482 extend-filesystems[1121]: Checking size of /dev/vda9 Apr 12 18:51:15.877244 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Apr 12 18:51:15.885521 dbus-daemon[1119]: [system] SELinux support is enabled Apr 12 18:51:15.877305 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 12 18:51:15.919241 extend-filesystems[1121]: Old size kept for /dev/vda9 Apr 12 18:51:15.877818 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 12 18:51:15.920967 jq[1138]: true Apr 12 18:51:15.879420 systemd[1]: Starting update-engine.service... Apr 12 18:51:15.883611 systemd[1]: Starting update-ssh-keys-after-ignition.service... Apr 12 18:51:15.921588 jq[1143]: true Apr 12 18:51:15.886118 systemd[1]: Started dbus.service. Apr 12 18:51:15.895645 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 12 18:51:15.948751 update_engine[1137]: I0412 18:51:15.922473 1137 main.cc:92] Flatcar Update Engine starting Apr 12 18:51:15.895819 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Apr 12 18:51:15.896156 systemd[1]: motdgen.service: Deactivated successfully. Apr 12 18:51:15.896322 systemd[1]: Finished motdgen.service. Apr 12 18:51:15.904138 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 12 18:51:15.904296 systemd[1]: Finished ssh-key-proc-cmdline.service. Apr 12 18:51:15.910260 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). Apr 12 18:51:15.910300 systemd[1]: Reached target system-config.target. Apr 12 18:51:15.911496 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Apr 12 18:51:15.911515 systemd[1]: Reached target user-config.target. Apr 12 18:51:15.915944 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 12 18:51:15.916161 systemd[1]: Finished extend-filesystems.service. Apr 12 18:51:16.057390 systemd-logind[1131]: Watching system buttons on /dev/input/event1 (Power Button) Apr 12 18:51:16.057413 systemd-logind[1131]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Apr 12 18:51:16.057947 systemd-logind[1131]: New seat seat0. Apr 12 18:51:16.058384 bash[1166]: Updated "/home/core/.ssh/authorized_keys" Apr 12 18:51:16.058989 systemd[1]: Finished update-ssh-keys-after-ignition.service. Apr 12 18:51:16.062330 systemd[1]: Started systemd-logind.service. Apr 12 18:51:16.069570 systemd[1]: Started update-engine.service. Apr 12 18:51:16.073201 update_engine[1137]: I0412 18:51:16.072537 1137 update_check_scheduler.cc:74] Next update check in 7m29s Apr 12 18:51:16.072716 systemd[1]: Started locksmithd.service. Apr 12 18:51:16.077815 env[1144]: time="2024-04-12T18:51:16.077779185Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Apr 12 18:51:16.092852 env[1144]: time="2024-04-12T18:51:16.092803767Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 12 18:51:16.093113 env[1144]: time="2024-04-12T18:51:16.093094772Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 12 18:51:16.094397 env[1144]: time="2024-04-12T18:51:16.094373832Z" 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.154-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Apr 12 18:51:16.094465 env[1144]: time="2024-04-12T18:51:16.094447309Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 12 18:51:16.094707 env[1144]: time="2024-04-12T18:51:16.094687901Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (xfs) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Apr 12 18:51:16.094782 env[1144]: time="2024-04-12T18:51:16.094763312Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 12 18:51:16.094852 env[1144]: time="2024-04-12T18:51:16.094833113Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Apr 12 18:51:16.094917 env[1144]: time="2024-04-12T18:51:16.094899317Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 12 18:51:16.095042 env[1144]: time="2024-04-12T18:51:16.095025013Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 12 18:51:16.095327 env[1144]: time="2024-04-12T18:51:16.095310268Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 12 18:51:16.095504 env[1144]: time="2024-04-12T18:51:16.095483603Z" 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 Apr 12 18:51:16.095579 env[1144]: time="2024-04-12T18:51:16.095558253Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 12 18:51:16.095676 env[1144]: time="2024-04-12T18:51:16.095658241Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Apr 12 18:51:16.095742 env[1144]: time="2024-04-12T18:51:16.095724806Z" level=info msg="metadata content store policy set" policy=shared Apr 12 18:51:16.100422 env[1144]: time="2024-04-12T18:51:16.100402189Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 12 18:51:16.100502 env[1144]: time="2024-04-12T18:51:16.100484353Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 12 18:51:16.100571 env[1144]: time="2024-04-12T18:51:16.100553813Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 12 18:51:16.100667 env[1144]: time="2024-04-12T18:51:16.100648010Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 12 18:51:16.100748 env[1144]: time="2024-04-12T18:51:16.100728942Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 12 18:51:16.100818 env[1144]: time="2024-04-12T18:51:16.100800907Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 12 18:51:16.100894 env[1144]: time="2024-04-12T18:51:16.100876258Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 12 18:51:16.100967 env[1144]: time="2024-04-12T18:51:16.100949305Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 12 18:51:16.101052 env[1144]: time="2024-04-12T18:51:16.101033774Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Apr 12 18:51:16.101124 env[1144]: time="2024-04-12T18:51:16.101105699Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 12 18:51:16.101194 env[1144]: time="2024-04-12T18:51:16.101176341Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 12 18:51:16.101287 env[1144]: time="2024-04-12T18:51:16.101256351Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 12 18:51:16.101436 env[1144]: time="2024-04-12T18:51:16.101419597Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 12 18:51:16.101562 env[1144]: time="2024-04-12T18:51:16.101545574Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 12 18:51:16.101857 env[1144]: time="2024-04-12T18:51:16.101840537Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 12 18:51:16.101951 env[1144]: time="2024-04-12T18:51:16.101932069Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.102037 env[1144]: time="2024-04-12T18:51:16.102015525Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 12 18:51:16.102169 env[1144]: time="2024-04-12T18:51:16.102146932Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.102263 env[1144]: time="2024-04-12T18:51:16.102245767Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.102350 env[1144]: time="2024-04-12T18:51:16.102332349Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.102431 env[1144]: time="2024-04-12T18:51:16.102412700Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.102507 env[1144]: time="2024-04-12T18:51:16.102488993Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.102578 env[1144]: time="2024-04-12T18:51:16.102560467Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.102650 env[1144]: time="2024-04-12T18:51:16.102632893Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.102720 env[1144]: time="2024-04-12T18:51:16.102702474Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.102798 env[1144]: time="2024-04-12T18:51:16.102780460Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 12 18:51:16.102940 env[1144]: time="2024-04-12T18:51:16.102922677Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.103023 env[1144]: time="2024-04-12T18:51:16.103005342Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.103094 env[1144]: time="2024-04-12T18:51:16.103075323Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.103168 env[1144]: time="2024-04-12T18:51:16.103150083Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 12 18:51:16.103242 env[1144]: time="2024-04-12T18:51:16.103222239Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Apr 12 18:51:16.103320 env[1144]: time="2024-04-12T18:51:16.103302629Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 12 18:51:16.103404 env[1144]: time="2024-04-12T18:51:16.103385515Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Apr 12 18:51:16.103496 env[1144]: time="2024-04-12T18:51:16.103479090Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 12 18:51:16.103795 env[1144]: time="2024-04-12T18:51:16.103746031Z" 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}" Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.103903607Z" level=info msg="Connect containerd service" Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.103954202Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.104494896Z" 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" Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.104612055Z" level=info msg="Start subscribing containerd event" Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.107603006Z" level=info msg="Start recovering state" Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.107719434Z" level=info msg="Start event monitor" Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.107738700Z" level=info msg="Start snapshots syncer" Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.107754269Z" level=info msg="Start cni network conf syncer for default" Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.107763477Z" level=info msg="Start streaming server" Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.108900790Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.108960141Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 12 18:51:16.113189 env[1144]: time="2024-04-12T18:51:16.109836705Z" level=info msg="containerd successfully booted in 0.032810s" Apr 12 18:51:16.109123 systemd[1]: Started containerd.service. Apr 12 18:51:16.180309 locksmithd[1168]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 12 18:51:16.424914 sshd_keygen[1139]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 12 18:51:16.450163 systemd[1]: Finished sshd-keygen.service. Apr 12 18:51:16.452254 systemd[1]: Starting issuegen.service... Apr 12 18:51:16.457683 systemd[1]: issuegen.service: Deactivated successfully. Apr 12 18:51:16.457873 systemd[1]: Finished issuegen.service. Apr 12 18:51:16.460487 systemd[1]: Starting systemd-user-sessions.service... Apr 12 18:51:16.466486 systemd[1]: Finished systemd-user-sessions.service. Apr 12 18:51:16.469053 systemd[1]: Started getty@tty1.service. Apr 12 18:51:16.471311 systemd[1]: Started serial-getty@ttyS0.service. Apr 12 18:51:16.472450 systemd[1]: Reached target getty.target. Apr 12 18:51:16.473376 systemd[1]: Reached target multi-user.target. Apr 12 18:51:16.475557 systemd[1]: Starting systemd-update-utmp-runlevel.service... Apr 12 18:51:16.483297 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Apr 12 18:51:16.483491 systemd[1]: Finished systemd-update-utmp-runlevel.service. Apr 12 18:51:16.485077 systemd[1]: Startup finished in 688ms (kernel) + 4.460s (initrd) + 7.467s (userspace) = 12.615s. Apr 12 18:51:17.057511 systemd-networkd[1047]: eth0: Gained IPv6LL Apr 12 18:51:25.468679 systemd[1]: Created slice system-sshd.slice. Apr 12 18:51:25.469651 systemd[1]: Started sshd@0-10.0.0.87:22-10.0.0.1:38168.service. Apr 12 18:51:25.511282 sshd[1192]: Accepted publickey for core from 10.0.0.1 port 38168 ssh2: RSA SHA256:YcqR9Dqo/1Ybntt1aIORABiFzXA47j16nwHTSfCmLBw Apr 12 18:51:25.513293 sshd[1192]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Apr 12 18:51:25.521530 systemd-logind[1131]: New session 1 of user core. Apr 12 18:51:25.522428 systemd[1]: Created slice user-500.slice. Apr 12 18:51:25.523476 systemd[1]: Starting user-runtime-dir@500.service... Apr 12 18:51:25.532253 systemd[1]: Finished user-runtime-dir@500.service. Apr 12 18:51:25.533360 systemd[1]: Starting user@500.service... Apr 12 18:51:25.535703 (systemd)[1195]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 12 18:51:25.598485 systemd[1195]: Queued start job for default target default.target. Apr 12 18:51:25.598926 systemd[1195]: Reached target paths.target. Apr 12 18:51:25.598943 systemd[1195]: Reached target sockets.target. Apr 12 18:51:25.598953 systemd[1195]: Reached target timers.target. Apr 12 18:51:25.598962 systemd[1195]: Reached target basic.target. Apr 12 18:51:25.598993 systemd[1195]: Reached target default.target. Apr 12 18:51:25.599013 systemd[1195]: Startup finished in 58ms. Apr 12 18:51:25.599084 systemd[1]: Started user@500.service. Apr 12 18:51:25.599983 systemd[1]: Started session-1.scope. Apr 12 18:51:25.652572 systemd[1]: Started sshd@1-10.0.0.87:22-10.0.0.1:38176.service. Apr 12 18:51:25.689849 sshd[1204]: Accepted publickey for core from 10.0.0.1 port 38176 ssh2: RSA SHA256:YcqR9Dqo/1Ybntt1aIORABiFzXA47j16nwHTSfCmLBw Apr 12 18:51:25.691460 sshd[1204]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Apr 12 18:51:25.695777 systemd-logind[1131]: New session 2 of user core. Apr 12 18:51:25.696893 systemd[1]: Started session-2.scope. Apr 12 18:51:25.754436 sshd[1204]: pam_unix(sshd:session): session closed for user core Apr 12 18:51:25.772066 systemd[1]: Started sshd@2-10.0.0.87:22-10.0.0.1:38190.service. Apr 12 18:51:25.772638 systemd[1]: sshd@1-10.0.0.87:22-10.0.0.1:38176.service: Deactivated successfully. Apr 12 18:51:25.773168 systemd[1]: session-2.scope: Deactivated successfully. Apr 12 18:51:25.773744 systemd-logind[1131]: Session 2 logged out. Waiting for processes to exit. Apr 12 18:51:25.774700 systemd-logind[1131]: Removed session 2. Apr 12 18:51:25.813466 sshd[1209]: Accepted publickey for core from 10.0.0.1 port 38190 ssh2: RSA SHA256:YcqR9Dqo/1Ybntt1aIORABiFzXA47j16nwHTSfCmLBw Apr 12 18:51:25.814896 sshd[1209]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Apr 12 18:51:25.818317 systemd-logind[1131]: New session 3 of user core. Apr 12 18:51:25.819289 systemd[1]: Started session-3.scope. Apr 12 18:51:25.869799 sshd[1209]: pam_unix(sshd:session): session closed for user core Apr 12 18:51:25.873120 systemd[1]: sshd@2-10.0.0.87:22-10.0.0.1:38190.service: Deactivated successfully. Apr 12 18:51:25.873815 systemd[1]: session-3.scope: Deactivated successfully. Apr 12 18:51:25.874538 systemd-logind[1131]: Session 3 logged out. Waiting for processes to exit. Apr 12 18:51:25.875709 systemd[1]: Started sshd@3-10.0.0.87:22-10.0.0.1:38194.service. Apr 12 18:51:25.876696 systemd-logind[1131]: Removed session 3. Apr 12 18:51:25.918706 sshd[1216]: Accepted publickey for core from 10.0.0.1 port 38194 ssh2: RSA SHA256:YcqR9Dqo/1Ybntt1aIORABiFzXA47j16nwHTSfCmLBw Apr 12 18:51:25.920405 sshd[1216]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Apr 12 18:51:25.924372 systemd-logind[1131]: New session 4 of user core. Apr 12 18:51:25.925120 systemd[1]: Started session-4.scope. Apr 12 18:51:25.982384 sshd[1216]: pam_unix(sshd:session): session closed for user core Apr 12 18:51:25.985597 systemd[1]: sshd@3-10.0.0.87:22-10.0.0.1:38194.service: Deactivated successfully. Apr 12 18:51:25.986240 systemd[1]: session-4.scope: Deactivated successfully. Apr 12 18:51:25.986827 systemd-logind[1131]: Session 4 logged out. Waiting for processes to exit. Apr 12 18:51:25.988164 systemd[1]: Started sshd@4-10.0.0.87:22-10.0.0.1:38200.service. Apr 12 18:51:25.988905 systemd-logind[1131]: Removed session 4. Apr 12 18:51:26.028075 sshd[1222]: Accepted publickey for core from 10.0.0.1 port 38200 ssh2: RSA SHA256:YcqR9Dqo/1Ybntt1aIORABiFzXA47j16nwHTSfCmLBw Apr 12 18:51:26.029699 sshd[1222]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Apr 12 18:51:26.033889 systemd-logind[1131]: New session 5 of user core. Apr 12 18:51:26.034628 systemd[1]: Started session-5.scope. Apr 12 18:51:26.097167 sudo[1225]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Apr 12 18:51:26.097450 sudo[1225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Apr 12 18:51:26.109617 dbus-daemon[1119]: \xd0\u001d\u0003\xbf3V: received setenforce notice (enforcing=411532448) Apr 12 18:51:26.111763 sudo[1225]: pam_unix(sudo:session): session closed for user root Apr 12 18:51:26.113769 sshd[1222]: pam_unix(sshd:session): session closed for user core Apr 12 18:51:26.117070 systemd[1]: Started sshd@5-10.0.0.87:22-10.0.0.1:38206.service. Apr 12 18:51:26.117474 systemd[1]: sshd@4-10.0.0.87:22-10.0.0.1:38200.service: Deactivated successfully. Apr 12 18:51:26.118208 systemd-logind[1131]: Session 5 logged out. Waiting for processes to exit. Apr 12 18:51:26.118223 systemd[1]: session-5.scope: Deactivated successfully. Apr 12 18:51:26.119216 systemd-logind[1131]: Removed session 5. Apr 12 18:51:26.153126 sshd[1228]: Accepted publickey for core from 10.0.0.1 port 38206 ssh2: RSA SHA256:YcqR9Dqo/1Ybntt1aIORABiFzXA47j16nwHTSfCmLBw Apr 12 18:51:26.154447 sshd[1228]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Apr 12 18:51:26.158601 systemd-logind[1131]: New session 6 of user core. Apr 12 18:51:26.159714 systemd[1]: Started session-6.scope. Apr 12 18:51:26.215652 sudo[1233]: 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 Apr 12 18:51:26.215914 sudo[1233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Apr 12 18:51:26.219601 sudo[1233]: pam_unix(sudo:session): session closed for user root Apr 12 18:51:26.224070 sudo[1232]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Apr 12 18:51:26.224238 sudo[1232]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Apr 12 18:51:26.235539 systemd[1]: Stopping audit-rules.service... Apr 12 18:51:26.235000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Apr 12 18:51:26.236994 auditctl[1236]: No rules Apr 12 18:51:26.237727 kernel: kauditd_printk_skb: 180 callbacks suppressed Apr 12 18:51:26.237761 kernel: audit: type=1305 audit(1712947886.235:161): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Apr 12 18:51:26.238073 systemd[1]: audit-rules.service: Deactivated successfully. Apr 12 18:51:26.238318 systemd[1]: Stopped audit-rules.service. Apr 12 18:51:26.235000 audit[1236]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffc29fd6a20 a2=420 a3=0 items=0 ppid=1 pid=1236 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) Apr 12 18:51:26.240501 systemd[1]: Starting audit-rules.service... Apr 12 18:51:26.244326 kernel: audit: type=1300 audit(1712947886.235:161): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffc29fd6a20 a2=420 a3=0 items=0 ppid=1 pid=1236 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) Apr 12 18:51:26.244406 kernel: audit: type=1327 audit(1712947886.235:161): proctitle=2F7362696E2F617564697463746C002D44 Apr 12 18:51:26.235000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Apr 12 18:51:26.248898 kernel: audit: type=1131 audit(1712947886.237:162): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.237000 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' Apr 12 18:51:26.260498 augenrules[1253]: No rules Apr 12 18:51:26.261262 systemd[1]: Finished audit-rules.service. Apr 12 18:51:26.260000 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' Apr 12 18:51:26.262738 sudo[1232]: pam_unix(sudo:session): session closed for user root Apr 12 18:51:26.264190 sshd[1228]: pam_unix(sshd:session): session closed for user core Apr 12 18:51:26.261000 audit[1232]: USER_END pid=1232 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' Apr 12 18:51:26.267821 systemd[1]: Started sshd@6-10.0.0.87:22-10.0.0.1:38210.service. Apr 12 18:51:26.268217 systemd[1]: sshd@5-10.0.0.87:22-10.0.0.1:38206.service: Deactivated successfully. Apr 12 18:51:26.268798 systemd[1]: session-6.scope: Deactivated successfully. Apr 12 18:51:26.269214 kernel: audit: type=1130 audit(1712947886.260:163): 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' Apr 12 18:51:26.269263 kernel: audit: type=1106 audit(1712947886.261:164): pid=1232 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' Apr 12 18:51:26.269306 kernel: audit: type=1104 audit(1712947886.261:165): pid=1232 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' Apr 12 18:51:26.261000 audit[1232]: CRED_DISP pid=1232 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' Apr 12 18:51:26.269777 systemd-logind[1131]: Session 6 logged out. Waiting for processes to exit. Apr 12 18:51:26.270967 systemd-logind[1131]: Removed session 6. Apr 12 18:51:26.273061 kernel: audit: type=1106 audit(1712947886.264:166): pid=1228 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=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.264000 audit[1228]: USER_END pid=1228 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=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.277943 kernel: audit: type=1104 audit(1712947886.264:167): pid=1228 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=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.264000 audit[1228]: CRED_DISP pid=1228 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=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.281304 kernel: audit: type=1130 audit(1712947886.266:168): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.87:22-10.0.0.1:38210 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.266000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.87:22-10.0.0.1:38210 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.267000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.0.0.87:22-10.0.0.1:38206 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.308000 audit[1258]: USER_ACCT pid=1258 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.309891 sshd[1258]: Accepted publickey for core from 10.0.0.1 port 38210 ssh2: RSA SHA256:YcqR9Dqo/1Ybntt1aIORABiFzXA47j16nwHTSfCmLBw Apr 12 18:51:26.309000 audit[1258]: CRED_ACQ pid=1258 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.309000 audit[1258]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=5 a1=7ffc4d684d80 a2=3 a3=0 items=0 ppid=1 pid=1258 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=7 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Apr 12 18:51:26.309000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Apr 12 18:51:26.310887 sshd[1258]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Apr 12 18:51:26.314976 systemd-logind[1131]: New session 7 of user core. Apr 12 18:51:26.315936 systemd[1]: Started session-7.scope. Apr 12 18:51:26.318000 audit[1258]: USER_START pid=1258 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.319000 audit[1261]: CRED_ACQ pid=1261 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.365000 audit[1262]: USER_ACCT pid=1262 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.366000 audit[1262]: CRED_REFR pid=1262 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.367315 sudo[1262]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s UUID -o value /dev/disk/by-label/ROOT Apr 12 18:51:26.367477 sudo[1262]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Apr 12 18:51:26.367000 audit[1262]: USER_START pid=1262 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.371568 sudo[1262]: pam_unix(sudo:session): session closed for user root Apr 12 18:51:26.370000 audit[1262]: USER_END pid=1262 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.370000 audit[1262]: CRED_DISP pid=1262 uid=500 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.372669 sshd[1258]: pam_unix(sshd:session): session closed for user core Apr 12 18:51:26.372000 audit[1258]: USER_END pid=1258 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.372000 audit[1258]: CRED_DISP pid=1258 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.375262 systemd[1]: sshd@6-10.0.0.87:22-10.0.0.1:38210.service: Deactivated successfully. Apr 12 18:51:26.374000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.87:22-10.0.0.1:38210 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.375822 systemd[1]: session-7.scope: Deactivated successfully. Apr 12 18:51:26.376286 systemd-logind[1131]: Session 7 logged out. Waiting for processes to exit. Apr 12 18:51:26.377218 systemd[1]: Started sshd@7-10.0.0.87:22-10.0.0.1:38216.service. Apr 12 18:51:26.376000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.0.0.87:22-10.0.0.1:38216 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.377837 systemd-logind[1131]: Removed session 7. Apr 12 18:51:26.412000 audit[1266]: USER_ACCT pid=1266 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.414137 sshd[1266]: Accepted publickey for core from 10.0.0.1 port 38216 ssh2: RSA SHA256:YcqR9Dqo/1Ybntt1aIORABiFzXA47j16nwHTSfCmLBw Apr 12 18:51:26.413000 audit[1266]: CRED_ACQ pid=1266 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.413000 audit[1266]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=5 a1=7ffd79b1f4c0 a2=3 a3=0 items=0 ppid=1 pid=1266 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=8 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Apr 12 18:51:26.413000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Apr 12 18:51:26.415283 sshd[1266]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Apr 12 18:51:26.419439 systemd-logind[1131]: New session 8 of user core. Apr 12 18:51:26.420567 systemd[1]: Started session-8.scope. Apr 12 18:51:26.423000 audit[1266]: USER_START pid=1266 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.425000 audit[1268]: CRED_ACQ pid=1268 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.474000 audit[1269]: USER_ACCT pid=1269 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.474000 audit[1269]: CRED_REFR pid=1269 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.475992 sudo[1269]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s TYPE -o value /dev/disk/by-label/ROOT Apr 12 18:51:26.476251 sudo[1269]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Apr 12 18:51:26.476000 audit[1269]: USER_START pid=1269 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.479738 sudo[1269]: pam_unix(sudo:session): session closed for user root Apr 12 18:51:26.478000 audit[1269]: USER_END pid=1269 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.478000 audit[1269]: CRED_DISP pid=1269 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.481086 sshd[1266]: pam_unix(sshd:session): session closed for user core Apr 12 18:51:26.480000 audit[1266]: USER_END pid=1266 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.480000 audit[1266]: CRED_DISP pid=1266 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.483984 systemd[1]: sshd@7-10.0.0.87:22-10.0.0.1:38216.service: Deactivated successfully. Apr 12 18:51:26.482000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.0.0.87:22-10.0.0.1:38216 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.484588 systemd[1]: session-8.scope: Deactivated successfully. Apr 12 18:51:26.485194 systemd-logind[1131]: Session 8 logged out. Waiting for processes to exit. Apr 12 18:51:26.486278 systemd[1]: Started sshd@8-10.0.0.87:22-10.0.0.1:38220.service. Apr 12 18:51:26.485000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-10.0.0.87:22-10.0.0.1:38220 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.487058 systemd-logind[1131]: Removed session 8. Apr 12 18:51:26.523000 audit[1273]: USER_ACCT pid=1273 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.524539 sshd[1273]: Accepted publickey for core from 10.0.0.1 port 38220 ssh2: RSA SHA256:YcqR9Dqo/1Ybntt1aIORABiFzXA47j16nwHTSfCmLBw Apr 12 18:51:26.524000 audit[1273]: CRED_ACQ pid=1273 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.524000 audit[1273]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=5 a1=7ffd84a0d600 a2=3 a3=0 items=0 ppid=1 pid=1273 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=9 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Apr 12 18:51:26.524000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Apr 12 18:51:26.525905 sshd[1273]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Apr 12 18:51:26.529490 systemd-logind[1131]: New session 9 of user core. Apr 12 18:51:26.530240 systemd[1]: Started session-9.scope. Apr 12 18:51:26.534000 audit[1273]: USER_START pid=1273 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.535000 audit[1276]: CRED_ACQ pid=1276 uid=0 auid=500 ses=9 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=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.583217 sshd[1273]: pam_unix(sshd:session): session closed for user core Apr 12 18:51:26.582000 audit[1273]: USER_END pid=1273 uid=0 auid=500 ses=9 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=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.583000 audit[1273]: CRED_DISP pid=1273 uid=0 auid=500 ses=9 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=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Apr 12 18:51:26.585535 systemd[1]: sshd@8-10.0.0.87:22-10.0.0.1:38220.service: Deactivated successfully. Apr 12 18:51:26.584000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-10.0.0.87:22-10.0.0.1:38220 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 12 18:51:26.586170 systemd[1]: session-9.scope: Deactivated successfully. Apr 12 18:51:26.586742 systemd-logind[1131]: Session 9 logged out. Waiting for processes to exit. Apr 12 18:51:26.587503 systemd-logind[1131]: Removed session 9.