Jan 23 18:57:16.014510 kernel: Linux version 5.10.107-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 9.3.0-r1 p3) 9.3.0, GNU ld (Gentoo 2.36.1 p5) 2.36.1) #1 SMP Tue Mar 22 19:39:53 -00 2022 Jan 23 18:57:16.014529 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=15990f5bb88d618f1948b7e8a720f1d5b95900cfecbef00df890bd0a136b39aa Jan 23 18:57:16.014536 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jan 23 18:57:16.014541 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jan 23 18:57:16.014545 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jan 23 18:57:16.014549 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jan 23 18:57:16.014554 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Jan 23 18:57:16.014559 kernel: BIOS-provided physical RAM map: Jan 23 18:57:16.014563 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Jan 23 18:57:16.014567 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Jan 23 18:57:16.014571 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Jan 23 18:57:16.014576 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Jan 23 18:57:16.014580 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Jan 23 18:57:16.014584 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Jan 23 18:57:16.014591 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Jan 23 18:57:16.014595 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jan 23 18:57:16.014599 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Jan 23 18:57:16.014603 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Jan 23 18:57:16.014607 kernel: NX (Execute Disable) protection: active Jan 23 18:57:16.014612 kernel: SMBIOS 2.8 present. Jan 23 18:57:16.014616 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Jan 23 18:57:16.014620 kernel: Hypervisor detected: KVM Jan 23 18:57:16.014624 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jan 23 18:57:16.014628 kernel: kvm-clock: cpu 0, msr 996ba001, primary cpu clock Jan 23 18:57:16.014633 kernel: kvm-clock: using sched offset of 10321613928 cycles Jan 23 18:57:16.014638 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jan 23 18:57:16.014643 kernel: tsc: Detected 2445.426 MHz processor Jan 23 18:57:16.014648 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jan 23 18:57:16.014653 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jan 23 18:57:16.014658 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Jan 23 18:57:16.014662 kernel: MTRR default type: write-back Jan 23 18:57:16.014666 kernel: MTRR fixed ranges enabled: Jan 23 18:57:16.014671 kernel: 00000-9FFFF write-back Jan 23 18:57:16.014675 kernel: A0000-BFFFF uncachable Jan 23 18:57:16.014680 kernel: C0000-FFFFF write-protect Jan 23 18:57:16.014685 kernel: MTRR variable ranges enabled: Jan 23 18:57:16.014690 kernel: 0 base 0000C0000000 mask FFFFC0000000 uncachable Jan 23 18:57:16.014694 kernel: 1 disabled Jan 23 18:57:16.014698 kernel: 2 disabled Jan 23 18:57:16.014703 kernel: 3 disabled Jan 23 18:57:16.014709 kernel: 4 disabled Jan 23 18:57:16.014713 kernel: 5 disabled Jan 23 18:57:16.014718 kernel: 6 disabled Jan 23 18:57:16.014723 kernel: 7 disabled Jan 23 18:57:16.014728 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jan 23 18:57:16.014733 kernel: Using GB pages for direct mapping Jan 23 18:57:16.014737 kernel: ACPI: Early table checksum verification disabled Jan 23 18:57:16.014742 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Jan 23 18:57:16.014746 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 23 18:57:16.014751 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jan 23 18:57:16.014756 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 23 18:57:16.014760 kernel: ACPI: FACS 0x000000009CFE0000 000040 Jan 23 18:57:16.014765 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 23 18:57:16.014771 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 23 18:57:16.014775 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 23 18:57:16.014780 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 23 18:57:16.014819 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Jan 23 18:57:16.014825 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Jan 23 18:57:16.014830 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Jan 23 18:57:16.014835 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Jan 23 18:57:16.014842 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Jan 23 18:57:16.014846 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Jan 23 18:57:16.014851 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Jan 23 18:57:16.014856 kernel: ACPI: Local APIC address 0xfee00000 Jan 23 18:57:16.014860 kernel: No NUMA configuration found Jan 23 18:57:16.014865 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Jan 23 18:57:16.014870 kernel: NODE_DATA(0) allocated [mem 0x9cfd6000-0x9cfdbfff] Jan 23 18:57:16.014875 kernel: Zone ranges: Jan 23 18:57:16.014879 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jan 23 18:57:16.014884 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Jan 23 18:57:16.014890 kernel: Normal empty Jan 23 18:57:16.014894 kernel: Movable zone start for each node Jan 23 18:57:16.014899 kernel: Early memory node ranges Jan 23 18:57:16.014904 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Jan 23 18:57:16.014908 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Jan 23 18:57:16.014913 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Jan 23 18:57:16.014917 kernel: On node 0 totalpages: 642938 Jan 23 18:57:16.014922 kernel: DMA zone: 64 pages used for memmap Jan 23 18:57:16.014926 kernel: DMA zone: 21 pages reserved Jan 23 18:57:16.014931 kernel: DMA zone: 3998 pages, LIFO batch:0 Jan 23 18:57:16.014937 kernel: DMA32 zone: 9984 pages used for memmap Jan 23 18:57:16.014941 kernel: DMA32 zone: 638940 pages, LIFO batch:63 Jan 23 18:57:16.014946 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jan 23 18:57:16.014951 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Jan 23 18:57:16.014955 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Jan 23 18:57:16.014960 kernel: ACPI: PM-Timer IO Port: 0x608 Jan 23 18:57:16.014965 kernel: ACPI: Local APIC address 0xfee00000 Jan 23 18:57:16.014969 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jan 23 18:57:16.014974 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jan 23 18:57:16.014978 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jan 23 18:57:16.014984 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jan 23 18:57:16.014989 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jan 23 18:57:16.014994 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jan 23 18:57:16.014998 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jan 23 18:57:16.015003 kernel: ACPI: IRQ0 used by override. Jan 23 18:57:16.015008 kernel: ACPI: IRQ5 used by override. Jan 23 18:57:16.015012 kernel: ACPI: IRQ9 used by override. Jan 23 18:57:16.015016 kernel: ACPI: IRQ10 used by override. Jan 23 18:57:16.015021 kernel: ACPI: IRQ11 used by override. Jan 23 18:57:16.015026 kernel: Using ACPI (MADT) for SMP configuration information Jan 23 18:57:16.015035 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jan 23 18:57:16.015040 kernel: TSC deadline timer available Jan 23 18:57:16.015045 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Jan 23 18:57:16.015050 kernel: kvm-guest: KVM setup pv remote TLB flush Jan 23 18:57:16.015054 kernel: kvm-guest: setup PV sched yield Jan 23 18:57:16.015059 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Jan 23 18:57:16.015064 kernel: Booting paravirtualized kernel on KVM Jan 23 18:57:16.015069 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jan 23 18:57:16.015074 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:4 nr_node_ids:1 Jan 23 18:57:16.015080 kernel: percpu: Embedded 58 pages/cpu s199704 r8192 d29672 u524288 Jan 23 18:57:16.015084 kernel: pcpu-alloc: s199704 r8192 d29672 u524288 alloc=1*2097152 Jan 23 18:57:16.015089 kernel: pcpu-alloc: [0] 0 1 2 3 Jan 23 18:57:16.015094 kernel: kvm-guest: KVM setup async PF for cpu 0 Jan 23 18:57:16.015098 kernel: kvm-guest: stealtime: cpu 0, msr 9a41c580 Jan 23 18:57:16.015103 kernel: kvm-guest: PV spinlocks enabled Jan 23 18:57:16.015108 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jan 23 18:57:16.015112 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632869 Jan 23 18:57:16.015117 kernel: Policy zone: DMA32 Jan 23 18:57:16.015127 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=15990f5bb88d618f1948b7e8a720f1d5b95900cfecbef00df890bd0a136b39aa Jan 23 18:57:16.015134 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 23 18:57:16.015139 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 23 18:57:16.015144 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 23 18:57:16.015149 kernel: Memory: 2449516K/2571752K available (10246K kernel code, 2239K rwdata, 11640K rodata, 42228K init, 1436K bss, 121976K reserved, 0K cma-reserved) Jan 23 18:57:16.015154 kernel: random: get_random_u64 called from __kmem_cache_create+0x26/0x400 with crng_init=0 Jan 23 18:57:16.015160 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jan 23 18:57:16.015165 kernel: ftrace: allocating 34378 entries in 135 pages Jan 23 18:57:16.015170 kernel: ftrace: allocated 135 pages with 4 groups Jan 23 18:57:16.015175 kernel: rcu: Hierarchical RCU implementation. Jan 23 18:57:16.015180 kernel: rcu: RCU event tracing is enabled. Jan 23 18:57:16.015185 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jan 23 18:57:16.015191 kernel: Rude variant of Tasks RCU enabled. Jan 23 18:57:16.015196 kernel: Tracing variant of Tasks RCU enabled. Jan 23 18:57:16.015200 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 23 18:57:16.015206 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jan 23 18:57:16.015211 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Jan 23 18:57:16.015216 kernel: Console: colour VGA+ 80x25 Jan 23 18:57:16.015221 kernel: printk: console [ttyS0] enabled Jan 23 18:57:16.015226 kernel: ACPI: Core revision 20200925 Jan 23 18:57:16.015231 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jan 23 18:57:16.015236 kernel: APIC: Switch to symmetric I/O mode setup Jan 23 18:57:16.015241 kernel: x2apic enabled Jan 23 18:57:16.015245 kernel: Switched APIC routing to physical x2apic. Jan 23 18:57:16.015250 kernel: kvm-guest: setup PV IPIs Jan 23 18:57:16.015256 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jan 23 18:57:16.015261 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Jan 23 18:57:16.015266 kernel: Calibrating delay loop (skipped) preset value.. 4890.85 BogoMIPS (lpj=2445426) Jan 23 18:57:16.015271 kernel: pid_max: default: 32768 minimum: 301 Jan 23 18:57:16.015276 kernel: LSM: Security Framework initializing Jan 23 18:57:16.015281 kernel: SELinux: Initializing. Jan 23 18:57:16.015286 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 23 18:57:16.015291 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 23 18:57:16.015295 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jan 23 18:57:16.015302 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Jan 23 18:57:16.015307 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Jan 23 18:57:16.015312 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jan 23 18:57:16.015376 kernel: Spectre V2 : Mitigation: Retpolines Jan 23 18:57:16.015387 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Jan 23 18:57:16.015395 kernel: Speculative Store Bypass: Vulnerable Jan 23 18:57:16.015400 kernel: Freeing SMP alternatives memory: 28K Jan 23 18:57:16.015405 kernel: smpboot: CPU0: AMD EPYC 7763 64-Core Processor (family: 0x19, model: 0x1, stepping: 0x1) Jan 23 18:57:16.015410 kernel: Performance Events: PMU not available due to virtualization, using software events only. Jan 23 18:57:16.015415 kernel: rcu: Hierarchical SRCU implementation. Jan 23 18:57:16.015420 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Jan 23 18:57:16.015425 kernel: smp: Bringing up secondary CPUs ... Jan 23 18:57:16.015430 kernel: x86: Booting SMP configuration: Jan 23 18:57:16.015435 kernel: .... node #0, CPUs: #1 Jan 23 18:57:16.015440 kernel: kvm-clock: cpu 1, msr 996ba041, secondary cpu clock Jan 23 18:57:16.015446 kernel: kvm-guest: KVM setup async PF for cpu 1 Jan 23 18:57:16.015451 kernel: kvm-guest: stealtime: cpu 1, msr 9a49c580 Jan 23 18:57:16.015456 kernel: #2 Jan 23 18:57:16.015461 kernel: kvm-clock: cpu 2, msr 996ba081, secondary cpu clock Jan 23 18:57:16.015466 kernel: kvm-guest: KVM setup async PF for cpu 2 Jan 23 18:57:16.015471 kernel: kvm-guest: stealtime: cpu 2, msr 9a51c580 Jan 23 18:57:16.015476 kernel: #3 Jan 23 18:57:16.015481 kernel: kvm-clock: cpu 3, msr 996ba0c1, secondary cpu clock Jan 23 18:57:16.015486 kernel: kvm-guest: KVM setup async PF for cpu 3 Jan 23 18:57:16.015492 kernel: kvm-guest: stealtime: cpu 3, msr 9a59c580 Jan 23 18:57:16.015497 kernel: smp: Brought up 1 node, 4 CPUs Jan 23 18:57:16.015502 kernel: smpboot: Max logical packages: 1 Jan 23 18:57:16.015507 kernel: smpboot: Total of 4 processors activated (19563.40 BogoMIPS) Jan 23 18:57:16.015512 kernel: devtmpfs: initialized Jan 23 18:57:16.015517 kernel: x86/mm: Memory block size: 128MB Jan 23 18:57:16.015522 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 23 18:57:16.015527 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jan 23 18:57:16.015532 kernel: pinctrl core: initialized pinctrl subsystem Jan 23 18:57:16.015537 kernel: NET: Registered protocol family 16 Jan 23 18:57:16.015543 kernel: audit: initializing netlink subsys (disabled) Jan 23 18:57:16.015548 kernel: audit: type=2000 audit(1769194630.986:1): state=initialized audit_enabled=0 res=1 Jan 23 18:57:16.015552 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 23 18:57:16.015557 kernel: thermal_sys: Registered thermal governor 'user_space' Jan 23 18:57:16.015562 kernel: cpuidle: using governor menu Jan 23 18:57:16.015567 kernel: ACPI: bus type PCI registered Jan 23 18:57:16.015572 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 23 18:57:16.015577 kernel: dca service started, version 1.12.1 Jan 23 18:57:16.015582 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Jan 23 18:57:16.015588 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved in E820 Jan 23 18:57:16.015593 kernel: PCI: Using configuration type 1 for base access Jan 23 18:57:16.015597 kernel: Kprobes globally optimized Jan 23 18:57:16.015602 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Jan 23 18:57:16.015607 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Jan 23 18:57:16.015612 kernel: ACPI: Added _OSI(Module Device) Jan 23 18:57:16.015617 kernel: ACPI: Added _OSI(Processor Device) Jan 23 18:57:16.015622 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jan 23 18:57:16.015627 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 23 18:57:16.015631 kernel: ACPI: Added _OSI(Linux-Dell-Video) Jan 23 18:57:16.015637 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Jan 23 18:57:16.015642 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Jan 23 18:57:16.015647 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 23 18:57:16.015652 kernel: ACPI: Interpreter enabled Jan 23 18:57:16.015657 kernel: ACPI: (supports S0 S3 S5) Jan 23 18:57:16.015662 kernel: ACPI: Using IOAPIC for interrupt routing Jan 23 18:57:16.015667 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jan 23 18:57:16.015672 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jan 23 18:57:16.015676 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jan 23 18:57:16.015770 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jan 23 18:57:16.015865 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Jan 23 18:57:16.015912 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Jan 23 18:57:16.015920 kernel: PCI host bridge to bus 0000:00 Jan 23 18:57:16.015968 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jan 23 18:57:16.016010 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jan 23 18:57:16.016054 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jan 23 18:57:16.016093 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Jan 23 18:57:16.016132 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jan 23 18:57:16.016169 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Jan 23 18:57:16.016207 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jan 23 18:57:16.016259 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Jan 23 18:57:16.016472 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Jan 23 18:57:16.016558 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Jan 23 18:57:16.016627 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Jan 23 18:57:16.016708 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Jan 23 18:57:16.016838 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Jan 23 18:57:16.016927 kernel: pci 0000:00:02.0: reg 0x10: [io 0xc0c0-0xc0df] Jan 23 18:57:16.017010 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Jan 23 18:57:16.017097 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Jan 23 18:57:16.017173 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Jan 23 18:57:16.017220 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc07f] Jan 23 18:57:16.017264 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Jan 23 18:57:16.017308 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Jan 23 18:57:16.017410 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Jan 23 18:57:16.017458 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc0e0-0xc0ff] Jan 23 18:57:16.017529 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Jan 23 18:57:16.017578 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Jan 23 18:57:16.017622 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Jan 23 18:57:16.017669 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Jan 23 18:57:16.017713 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jan 23 18:57:16.017758 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Jan 23 18:57:16.017930 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc100-0xc11f] Jan 23 18:57:16.018022 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfebd4000-0xfebd4fff] Jan 23 18:57:16.018086 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Jan 23 18:57:16.018131 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] Jan 23 18:57:16.018139 kernel: ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) Jan 23 18:57:16.018144 kernel: ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) Jan 23 18:57:16.018150 kernel: ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) Jan 23 18:57:16.018154 kernel: ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) Jan 23 18:57:16.018159 kernel: ACPI: PCI Interrupt Link [LNKE] (IRQs 5 *10 11) Jan 23 18:57:16.018165 kernel: ACPI: PCI Interrupt Link [LNKF] (IRQs 5 *10 11) Jan 23 18:57:16.018170 kernel: ACPI: PCI Interrupt Link [LNKG] (IRQs 5 10 *11) Jan 23 18:57:16.018176 kernel: ACPI: PCI Interrupt Link [LNKH] (IRQs 5 10 *11) Jan 23 18:57:16.018181 kernel: ACPI: PCI Interrupt Link [GSIA] (IRQs *16) Jan 23 18:57:16.018186 kernel: ACPI: PCI Interrupt Link [GSIB] (IRQs *17) Jan 23 18:57:16.018191 kernel: ACPI: PCI Interrupt Link [GSIC] (IRQs *18) Jan 23 18:57:16.018196 kernel: ACPI: PCI Interrupt Link [GSID] (IRQs *19) Jan 23 18:57:16.018201 kernel: ACPI: PCI Interrupt Link [GSIE] (IRQs *20) Jan 23 18:57:16.018206 kernel: ACPI: PCI Interrupt Link [GSIF] (IRQs *21) Jan 23 18:57:16.018211 kernel: ACPI: PCI Interrupt Link [GSIG] (IRQs *22) Jan 23 18:57:16.018216 kernel: ACPI: PCI Interrupt Link [GSIH] (IRQs *23) Jan 23 18:57:16.018222 kernel: iommu: Default domain type: Translated Jan 23 18:57:16.018265 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jan 23 18:57:16.018307 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jan 23 18:57:16.018420 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jan 23 18:57:16.018430 kernel: vgaarb: loaded Jan 23 18:57:16.018436 kernel: PCI: Using ACPI for IRQ routing Jan 23 18:57:16.018442 kernel: PCI: pci_cache_line_size set to 64 bytes Jan 23 18:57:16.018447 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Jan 23 18:57:16.018452 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Jan 23 18:57:16.018460 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jan 23 18:57:16.018465 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jan 23 18:57:16.018470 kernel: clocksource: Switched to clocksource kvm-clock Jan 23 18:57:16.018475 kernel: VFS: Disk quotas dquot_6.6.0 Jan 23 18:57:16.018480 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 23 18:57:16.018485 kernel: pnp: PnP ACPI init Jan 23 18:57:16.018536 kernel: pnp 00:00: Plug and Play ACPI device, IDs PNP0303 (active) Jan 23 18:57:16.018582 kernel: pnp 00:01: Plug and Play ACPI device, IDs PNP0f13 (active) Jan 23 18:57:16.018632 kernel: pnp 00:02: Plug and Play ACPI device, IDs PNP0400 (active) Jan 23 18:57:16.018676 kernel: pnp 00:03: Plug and Play ACPI device, IDs PNP0501 (active) Jan 23 18:57:16.018740 kernel: pnp 00:04: Plug and Play ACPI device, IDs PNP0b00 (active) Jan 23 18:57:16.018853 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Jan 23 18:57:16.018901 kernel: system 00:05: Plug and Play ACPI device, IDs PNP0c01 (active) Jan 23 18:57:16.018911 kernel: pnp: PnP ACPI: found 6 devices Jan 23 18:57:16.018917 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jan 23 18:57:16.018923 kernel: NET: Registered protocol family 2 Jan 23 18:57:16.018928 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 23 18:57:16.018933 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 23 18:57:16.018938 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 23 18:57:16.018943 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Jan 23 18:57:16.018948 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 23 18:57:16.018953 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 23 18:57:16.018959 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 23 18:57:16.018964 kernel: NET: Registered protocol family 1 Jan 23 18:57:16.018969 kernel: NET: Registered protocol family 44 Jan 23 18:57:16.019011 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jan 23 18:57:16.019050 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jan 23 18:57:16.019093 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jan 23 18:57:16.019131 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Jan 23 18:57:16.019169 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Jan 23 18:57:16.019206 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Jan 23 18:57:16.019253 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jan 23 18:57:16.019260 kernel: PCI: CLS 0 bytes, default 64 Jan 23 18:57:16.019265 kernel: Initialise system trusted keyrings Jan 23 18:57:16.019270 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 23 18:57:16.019275 kernel: Key type asymmetric registered Jan 23 18:57:16.019281 kernel: Asymmetric key parser 'x509' registered Jan 23 18:57:16.019286 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Jan 23 18:57:16.019291 kernel: io scheduler mq-deadline registered Jan 23 18:57:16.019296 kernel: io scheduler kyber registered Jan 23 18:57:16.019302 kernel: io scheduler bfq registered Jan 23 18:57:16.019307 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jan 23 18:57:16.019312 kernel: PCI Interrupt Link [GSIG] enabled at IRQ 22 Jan 23 18:57:16.019374 kernel: PCI Interrupt Link [GSIH] enabled at IRQ 23 Jan 23 18:57:16.019384 kernel: PCI Interrupt Link [GSIE] enabled at IRQ 20 Jan 23 18:57:16.019390 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 23 18:57:16.019395 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jan 23 18:57:16.019400 kernel: random: fast init done Jan 23 18:57:16.019405 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Jan 23 18:57:16.019412 kernel: random: crng init done Jan 23 18:57:16.019418 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Jan 23 18:57:16.019423 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jan 23 18:57:16.019428 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jan 23 18:57:16.019433 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jan 23 18:57:16.019483 kernel: rtc_cmos 00:04: RTC can wake from S4 Jan 23 18:57:16.019491 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jan 23 18:57:16.019530 kernel: rtc_cmos 00:04: registered as rtc0 Jan 23 18:57:16.019570 kernel: rtc_cmos 00:04: setting system clock to 2026-01-23T18:57:15 UTC (1769194635) Jan 23 18:57:16.019611 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Jan 23 18:57:16.019617 kernel: NET: Registered protocol family 10 Jan 23 18:57:16.019622 kernel: Segment Routing with IPv6 Jan 23 18:57:16.019627 kernel: NET: Registered protocol family 17 Jan 23 18:57:16.019632 kernel: Key type dns_resolver registered Jan 23 18:57:16.019637 kernel: IPI shorthand broadcast: enabled Jan 23 18:57:16.019642 kernel: sched_clock: Marking stable (4051302866, 1081446038)->(5522508476, -389759572) Jan 23 18:57:16.019648 kernel: registered taskstats version 1 Jan 23 18:57:16.019653 kernel: Loading compiled-in X.509 certificates Jan 23 18:57:16.019659 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: 5866c780451a04cc08b278527846e2b48fb1aa10' Jan 23 18:57:16.019665 kernel: Key type ._fscrypt registered Jan 23 18:57:16.019670 kernel: Key type .fscrypt registered Jan 23 18:57:16.019675 kernel: Key type fscrypt-provisioning registered Jan 23 18:57:16.019680 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 23 18:57:16.019685 kernel: ima: Allocated hash algorithm: sha1 Jan 23 18:57:16.019690 kernel: ima: No architecture policies found Jan 23 18:57:16.019695 kernel: Freeing unused kernel image (initmem) memory: 42228K Jan 23 18:57:16.019700 kernel: Write protecting the kernel read-only data: 24576k Jan 23 18:57:16.019706 kernel: Freeing unused kernel image (text/rodata gap) memory: 2040K Jan 23 18:57:16.019718 kernel: Freeing unused kernel image (rodata/data gap) memory: 648K Jan 23 18:57:16.019724 kernel: Run /init as init process Jan 23 18:57:16.019730 kernel: with arguments: Jan 23 18:57:16.019735 kernel: /init Jan 23 18:57:16.019740 kernel: with environment: Jan 23 18:57:16.019746 kernel: HOME=/ Jan 23 18:57:16.019751 kernel: TERM=linux Jan 23 18:57:16.019756 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jan 23 18:57:16.019763 systemd[1]: systemd 249 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 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Jan 23 18:57:16.019771 systemd[1]: Detected virtualization kvm. Jan 23 18:57:16.019777 systemd[1]: Detected architecture x86-64. Jan 23 18:57:16.019819 systemd[1]: Running in initial RAM disk. Jan 23 18:57:16.019832 systemd[1]: No hostname configured, using default hostname. Jan 23 18:57:16.019842 systemd[1]: Hostname set to . Jan 23 18:57:16.019850 systemd[1]: Initializing machine ID from VM UUID. Jan 23 18:57:16.019859 systemd[1]: Queued start job for default target Initrd Default Target. Jan 23 18:57:16.019868 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Jan 23 18:57:16.019874 systemd[1]: Reached target Local Encrypted Volumes. Jan 23 18:57:16.019879 systemd[1]: Reached target Path Units. Jan 23 18:57:16.019886 systemd[1]: Reached target Slice Units. Jan 23 18:57:16.019892 systemd[1]: Reached target Swaps. Jan 23 18:57:16.019897 systemd[1]: Reached target Timer Units. Jan 23 18:57:16.019903 systemd[1]: Listening on Open-iSCSI iscsid Socket. Jan 23 18:57:16.019909 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Jan 23 18:57:16.019915 systemd[1]: Listening on Journal Audit Socket. Jan 23 18:57:16.019921 systemd[1]: Listening on Journal Socket (/dev/log). Jan 23 18:57:16.019926 systemd[1]: Listening on Journal Socket. Jan 23 18:57:16.019932 systemd[1]: Listening on Network Service Netlink Socket. Jan 23 18:57:16.019938 systemd[1]: Listening on udev Control Socket. Jan 23 18:57:16.019943 systemd[1]: Listening on udev Kernel Socket. Jan 23 18:57:16.019948 systemd[1]: Reached target Socket Units. Jan 23 18:57:16.019954 systemd[1]: Starting Create List of Static Device Nodes... Jan 23 18:57:16.019959 systemd[1]: Finished Network Cleanup. Jan 23 18:57:16.019965 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Jan 23 18:57:16.019970 systemd[1]: Starting Journal Service... Jan 23 18:57:16.019976 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Jan 23 18:57:16.019982 systemd[1]: Starting Apply Kernel Variables... Jan 23 18:57:16.019988 systemd[1]: Starting Setup Virtual Console... Jan 23 18:57:16.019993 systemd[1]: Finished Create List of Static Device Nodes. Jan 23 18:57:16.020004 systemd-journald[192]: Journal started Jan 23 18:57:16.020053 systemd-journald[192]: Runtime Journal (/run/log/journal/5e5260523bc446b5ba731d0adb20d8da) is 6.0M, max 48.7M, 42.6M free. Jan 23 18:57:16.181000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.194462 kernel: audit: type=1130 audit(1769194636.181:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.194512 systemd[1]: Started Journal Service. Jan 23 18:57:16.201000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.202601 systemd[1]: Finished Apply Kernel Variables. Jan 23 18:57:16.235216 kernel: audit: type=1130 audit(1769194636.201:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.235248 kernel: audit: type=1130 audit(1769194636.217:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.217000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.235661 systemd[1]: Finished Setup Virtual Console. Jan 23 18:57:16.254830 kernel: audit: type=1130 audit(1769194636.238:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.238000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.256050 systemd[1]: Starting dracut ask for additional cmdline parameters... Jan 23 18:57:16.264755 systemd[1]: Starting Create Static Device Nodes in /dev... Jan 23 18:57:16.271126 systemd[1]: Finished dracut ask for additional cmdline parameters. Jan 23 18:57:16.291590 kernel: audit: type=1130 audit(1769194636.278:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.278000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.279031 systemd[1]: Finished Create Static Device Nodes in /dev. Jan 23 18:57:16.301000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.302615 systemd[1]: Starting dracut cmdline hook... Jan 23 18:57:16.320469 kernel: audit: type=1130 audit(1769194636.301:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.320532 dracut-cmdline[207]: dracut-dracut-053 Jan 23 18:57:16.320532 dracut-cmdline[207]: 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=LA Jan 23 18:57:16.320532 dracut-cmdline[207]: BEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=15990f5bb88d618f1948b7e8a720f1d5b95900cfecbef00df890bd0a136b39aa Jan 23 18:57:16.422391 kernel: SCSI subsystem initialized Jan 23 18:57:16.431480 kernel: Loading iSCSI transport class v2.0-870. Jan 23 18:57:16.446431 kernel: iscsi: registered transport (tcp) Jan 23 18:57:16.472415 kernel: iscsi: registered transport (qla4xxx) Jan 23 18:57:16.472513 kernel: QLogic iSCSI HBA Driver Jan 23 18:57:16.487923 systemd[1]: Finished dracut cmdline hook. Jan 23 18:57:16.493000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.495199 systemd[1]: Starting dracut pre-udev hook... Jan 23 18:57:16.511739 kernel: audit: type=1130 audit(1769194636.493:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.526414 kernel: device-mapper: uevent: version 1.0.3 Jan 23 18:57:16.526517 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Jan 23 18:57:16.586877 kernel: raid6: avx2x4 gen() 28406 MB/s Jan 23 18:57:16.605420 kernel: raid6: avx2x4 xor() 4760 MB/s Jan 23 18:57:16.624428 kernel: raid6: avx2x2 gen() 25990 MB/s Jan 23 18:57:16.648923 kernel: raid6: avx2x2 xor() 20853 MB/s Jan 23 18:57:16.667435 kernel: raid6: avx2x1 gen() 13233 MB/s Jan 23 18:57:16.686407 kernel: raid6: avx2x1 xor() 15280 MB/s Jan 23 18:57:16.705468 kernel: raid6: sse2x4 gen() 13914 MB/s Jan 23 18:57:16.724449 kernel: raid6: sse2x4 xor() 3506 MB/s Jan 23 18:57:16.749702 kernel: raid6: sse2x2 gen() 8900 MB/s Jan 23 18:57:16.768439 kernel: raid6: sse2x2 xor() 10112 MB/s Jan 23 18:57:16.787445 kernel: raid6: sse2x1 gen() 1064 MB/s Jan 23 18:57:16.809775 kernel: raid6: sse2x1 xor() 7341 MB/s Jan 23 18:57:16.809875 kernel: raid6: using algorithm avx2x4 gen() 28406 MB/s Jan 23 18:57:16.809887 kernel: raid6: .... xor() 4760 MB/s, rmw enabled Jan 23 18:57:16.811546 kernel: raid6: using avx2x2 recovery algorithm Jan 23 18:57:16.833427 kernel: xor: automatically using best checksumming function avx Jan 23 18:57:16.943623 kernel: Btrfs loaded, crc32c=crc32c-intel Jan 23 18:57:16.956653 systemd[1]: Finished dracut pre-udev hook. Jan 23 18:57:16.962000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.976000 audit: BPF prog-id=6 op=LOAD Jan 23 18:57:16.981691 kernel: audit: type=1130 audit(1769194636.962:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:16.981761 kernel: audit: type=1334 audit(1769194636.976:10): prog-id=6 op=LOAD Jan 23 18:57:16.981000 audit: BPF prog-id=7 op=LOAD Jan 23 18:57:16.986515 kernel: audit: type=1334 audit(1769194636.981:11): prog-id=7 op=LOAD Jan 23 18:57:16.986000 audit: BPF prog-id=8 op=LOAD Jan 23 18:57:16.987426 systemd[1]: Starting Rule-based Manager for Device Events and Files... Jan 23 18:57:16.998597 kernel: audit: type=1334 audit(1769194636.986:12): prog-id=8 op=LOAD Jan 23 18:57:17.021642 systemd-udevd[326]: /usr/lib64/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Jan 23 18:57:17.025437 systemd[1]: Started Rule-based Manager for Device Events and Files. Jan 23 18:57:17.033000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.035229 systemd[1]: Starting dracut pre-trigger hook... Jan 23 18:57:17.060246 kernel: audit: type=1130 audit(1769194637.033:13): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.060276 kernel: audit: type=1334 audit(1769194637.052:14): prog-id=9 op=LOAD Jan 23 18:57:17.052000 audit: BPF prog-id=9 op=LOAD Jan 23 18:57:17.060417 dracut-pre-trigger[333]: rd.md=0: removing MD RAID activation Jan 23 18:57:17.053561 systemd[1]: Starting Network Configuration... Jan 23 18:57:17.089150 systemd[1]: Finished dracut pre-trigger hook. Jan 23 18:57:17.116782 kernel: audit: type=1130 audit(1769194637.088:15): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.088000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.091073 systemd[1]: Starting Coldplug All udev Devices... Jan 23 18:57:17.103026 systemd-udevd[326]: /usr/lib64/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Jan 23 18:57:17.137290 systemd-networkd[345]: lo: Link UP Jan 23 18:57:17.137387 systemd-networkd[345]: lo: Gained carrier Jan 23 18:57:17.164122 kernel: audit: type=1130 audit(1769194637.143:16): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.143000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.137711 systemd-networkd[345]: Enumeration completed Jan 23 18:57:17.163000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.137889 systemd[1]: Started Network Configuration. Jan 23 18:57:17.203724 kernel: audit: type=1130 audit(1769194637.163:17): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.203757 kernel: audit: type=1334 audit(1769194637.167:18): prog-id=10 op=LOAD Jan 23 18:57:17.203769 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jan 23 18:57:17.203975 kernel: vda: detected capacity change from 0 to 4756340736 Jan 23 18:57:17.203991 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 23 18:57:17.167000 audit: BPF prog-id=10 op=LOAD Jan 23 18:57:17.144045 systemd[1]: Finished Coldplug All udev Devices. Jan 23 18:57:17.181442 systemd[1]: Starting Network Name Resolution... Jan 23 18:57:17.213915 kernel: libata version 3.00 loaded. Jan 23 18:57:17.217378 kernel: cryptd: max_cpu_qlen set to 1000 Jan 23 18:57:17.230690 kernel: ahci 0000:00:1f.2: version 3.0 Jan 23 18:57:17.230959 kernel: PCI Interrupt Link [GSIA] enabled at IRQ 16 Jan 23 18:57:17.237538 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Jan 23 18:57:17.237696 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jan 23 18:57:17.241644 systemd-udevd[371]: Using default interface naming scheme 'v249'. Jan 23 18:57:17.460700 kernel: AVX2 version of gcm_enc/dec engaged. Jan 23 18:57:17.460749 kernel: AES CTR mode by8 optimization enabled Jan 23 18:57:17.460764 kernel: scsi host0: ahci Jan 23 18:57:17.461007 kernel: scsi host1: ahci Jan 23 18:57:17.461121 kernel: scsi host2: ahci Jan 23 18:57:17.461229 kernel: scsi host3: ahci Jan 23 18:57:17.461386 kernel: scsi host4: ahci Jan 23 18:57:17.461507 kernel: scsi host5: ahci Jan 23 18:57:17.461619 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 Jan 23 18:57:17.461633 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 Jan 23 18:57:17.461648 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 Jan 23 18:57:17.461659 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 Jan 23 18:57:17.461671 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 Jan 23 18:57:17.461683 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 Jan 23 18:57:17.461694 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (383) Jan 23 18:57:17.266787 systemd-networkd[345]: eth0: Link UP Jan 23 18:57:17.466000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.276761 systemd-resolved[385]: Positive Trust Anchors: Jan 23 18:57:17.276772 systemd-resolved[385]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 23 18:57:17.276842 systemd-resolved[385]: 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 Jan 23 18:57:17.277135 systemd-resolved[385]: Defaulting to hostname 'linux'. Jan 23 18:57:17.279997 systemd[1]: Started Network Name Resolution. Jan 23 18:57:17.471854 systemd[1]: Found device /dev/disk/by-label/ROOT. Jan 23 18:57:17.478582 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Jan 23 18:57:17.484226 systemd[1]: Found device /dev/disk/by-label/OEM. Jan 23 18:57:17.547089 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 23 18:57:17.493085 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jan 23 18:57:17.512496 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Jan 23 18:57:17.519448 systemd[1]: Reached target Initrd Root Device. Jan 23 18:57:17.575516 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jan 23 18:57:17.576854 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jan 23 18:57:17.576872 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jan 23 18:57:17.576882 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jan 23 18:57:17.524510 systemd[1]: Reached target Network. Jan 23 18:57:17.607424 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jan 23 18:57:17.607453 kernel: ata3.00: applying bridge limits Jan 23 18:57:17.607461 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jan 23 18:57:17.607467 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jan 23 18:57:17.607474 kernel: ata3.00: configured for UDMA/100 Jan 23 18:57:17.607480 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jan 23 18:57:17.527032 systemd[1]: Reached target Host and Network Name Lookups. Jan 23 18:57:17.531445 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Jan 23 18:57:17.537784 systemd[1]: Starting iSCSI UserSpace I/O driver... Jan 23 18:57:17.678161 systemd[1]: Started iSCSI UserSpace I/O driver. Jan 23 18:57:17.678000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.679250 systemd[1]: Starting Open-iSCSI... Jan 23 18:57:17.690101 iscsid[456]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Jan 23 18:57:17.690101 iscsid[456]: 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 Jan 23 18:57:17.690101 iscsid[456]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Jan 23 18:57:17.690101 iscsid[456]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Jan 23 18:57:17.690101 iscsid[456]: If using hardware iscsi like qla4xxx this message can be ignored. Jan 23 18:57:17.690101 iscsid[456]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Jan 23 18:57:17.690101 iscsid[456]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Jan 23 18:57:17.759591 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jan 23 18:57:17.759771 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jan 23 18:57:17.760027 systemd[1]: Started Open-iSCSI. Jan 23 18:57:17.764000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.769448 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jan 23 18:57:17.780192 systemd[1]: Starting dracut initqueue hook... Jan 23 18:57:17.794160 systemd[1]: Finished dracut initqueue hook. Jan 23 18:57:17.798000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:17.799105 systemd[1]: Reached target Preparation for Remote File Systems. Jan 23 18:57:17.806217 systemd[1]: Reached target Remote Encrypted Volumes. Jan 23 18:57:17.809029 systemd[1]: Reached target Remote File Systems. Jan 23 18:57:17.818648 systemd[1]: Starting dracut pre-mount hook... Jan 23 18:57:17.829514 systemd[1]: Finished dracut pre-mount hook. Jan 23 18:57:17.834000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:18.285426 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Jan 23 18:57:18.285501 systemd-networkd[345]: eth0: Gained carrier Jan 23 18:57:18.297471 systemd-networkd[345]: eth0: DHCPv4 address 10.0.0.4/16 via 10.0.0.1 Jan 23 18:57:18.580590 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 23 18:57:18.582932 disk-uuid[453]: The operation has completed successfully. Jan 23 18:57:18.627755 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 23 18:57:18.627975 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Jan 23 18:57:18.634000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:18.634000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:18.636433 systemd[1]: Starting Ignition (setup)... Jan 23 18:57:18.668274 kernel: BTRFS info (device vda6): disk space caching is enabled Jan 23 18:57:18.668378 kernel: BTRFS info (device vda6): has skinny extents Jan 23 18:57:18.684523 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 23 18:57:18.696550 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 23 18:57:18.699650 systemd[1]: Finished Ignition (setup). Jan 23 18:57:18.705000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:18.705000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:18.707379 systemd[1]: Starting Ignition (disks)... Jan 23 18:57:18.768282 ignition[504]: Ignition v0.36.1-15-gde4e6cc9 Jan 23 18:57:18.768393 ignition[504]: Stage: disks Jan 23 18:57:18.768407 ignition[504]: reading system config file "/usr/lib/ignition/base.ign" Jan 23 18:57:18.768600 ignition[504]: no config at "/usr/lib/ignition/base.ign" Jan 23 18:57:18.768650 ignition[504]: parsed url from cmdline: "" Jan 23 18:57:18.768652 ignition[504]: no config URL provided Jan 23 18:57:18.768656 ignition[504]: reading system config file "/usr/lib/ignition/user.ign" Jan 23 18:57:18.768663 ignition[504]: no config at "/usr/lib/ignition/user.ign" Jan 23 18:57:18.768685 ignition[504]: op(1): [started] loading QEMU firmware config module Jan 23 18:57:18.768688 ignition[504]: op(1): executing: "modprobe" "qemu_fw_cfg" Jan 23 18:57:18.775148 ignition[504]: op(1): [finished] loading QEMU firmware config module Jan 23 18:57:18.834120 ignition[504]: parsing config with SHA512: 5f3d7ac9605fa6d2b4d59940a6a1501fa8daf4985011b5d4fab6ef228e648a0290d001852a4d0953870fcc8a93166043e796e37897c0e4e2299a21c1a4940179 Jan 23 18:57:18.857866 ignition[504]: disks: disks passed Jan 23 18:57:18.857905 ignition[504]: Ignition finished successfully Jan 23 18:57:18.863656 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 23 18:57:18.867304 systemd[1]: Finished Ignition (disks). Jan 23 18:57:18.873000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:18.873000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:18.873691 systemd[1]: Reached target Preparation for Local File Systems. Jan 23 18:57:18.882137 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Jan 23 18:57:18.888669 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Jan 23 18:57:18.905656 systemd-fsck[517]: ROOT: clean, 556/553792 files, 37783/553472 blocks Jan 23 18:57:18.918444 kernel: device-mapper: verity: sha256 using implementation "sha256-generic" Jan 23 18:57:18.919525 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Jan 23 18:57:18.927000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:18.929278 systemd[1]: Mounting /sysroot... Jan 23 18:57:18.965960 systemd[1]: Found device /dev/mapper/usr. Jan 23 18:57:18.972301 systemd[1]: Starting File System Check on /dev/mapper/usr... Jan 23 18:57:18.979608 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Jan 23 18:57:18.987000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=verity-setup comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.005722 systemd-fsck[531]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Jan 23 18:57:19.005722 systemd-fsck[531]: You must have r/w access to the filesystem or be root Jan 23 18:57:19.006284 systemd-fsck[528]: fsck failed with exit status 8. Jan 23 18:57:19.006288 systemd-fsck[528]: Ignoring error. Jan 23 18:57:19.019207 systemd[1]: Finished File System Check on /dev/mapper/usr. Jan 23 18:57:19.026000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.028299 systemd[1]: Mounting /sysusr/usr... Jan 23 18:57:19.054969 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Jan 23 18:57:19.055039 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Jan 23 18:57:19.055876 systemd[1]: Mounted /sysroot. Jan 23 18:57:19.059507 systemd[1]: Reached target Initrd Root File System. Jan 23 18:57:19.067464 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Jan 23 18:57:19.068122 systemd[1]: Mounted /sysusr/usr. Jan 23 18:57:19.068275 systemd[1]: Reached target Local File Systems. Jan 23 18:57:19.071576 systemd[1]: Reached target System Initialization. Jan 23 18:57:19.075713 systemd[1]: Reached target Basic System. Jan 23 18:57:19.081503 systemd[1]: Mounting /sysroot/usr... Jan 23 18:57:19.085550 systemd[1]: Mounted /sysroot/usr. Jan 23 18:57:19.093462 systemd[1]: Starting Root filesystem setup... Jan 23 18:57:19.152809 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 23 18:57:19.153039 systemd[1]: Finished Root filesystem setup. Jan 23 18:57:19.158000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.158000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.161865 systemd[1]: Starting Ignition (files)... Jan 23 18:57:19.163195 systemd[1]: Starting /sysroot/boot... Jan 23 18:57:19.195175 systemd[1]: Finished /sysroot/boot. Jan 23 18:57:19.195000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.210015 ignition[546]: Ignition v0.36.1-15-gde4e6cc9 Jan 23 18:57:19.210057 ignition[546]: Stage: files Jan 23 18:57:19.210073 ignition[546]: reading system config file "/usr/lib/ignition/base.ign" Jan 23 18:57:19.210090 ignition[546]: no config at "/usr/lib/ignition/base.ign" Jan 23 18:57:19.220122 ignition[546]: files: compiled without relabeling support, skipping Jan 23 18:57:19.279934 ignition[546]: files: createUsers: op(1): [started] creating or modifying user "core" Jan 23 18:57:19.280008 ignition[546]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Jan 23 18:57:19.285147 ignition[546]: files: createUsers: op(1): [finished] creating or modifying user "core" Jan 23 18:57:19.285170 ignition[546]: files: createUsers: op(2): [started] adding ssh keys to user "core" Jan 23 18:57:19.296813 ignition[546]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Jan 23 18:57:19.296944 ignition[546]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Jan 23 18:57:19.297918 ignition[546]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Jan 23 18:57:19.297927 ignition[546]: files: op(4): [started] processing unit "coreos-metadata.service" Jan 23 18:57:19.297958 ignition[546]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Jan 23 18:57:19.324654 systemd[1]: ignition-files.service: Deactivated successfully. Jan 23 18:57:19.298459 ignition[546]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Jan 23 18:57:19.333000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.333000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.330986 systemd[1]: Finished Ignition (files). Jan 23 18:57:19.298468 ignition[546]: files: op(4): [finished] processing unit "coreos-metadata.service" Jan 23 18:57:19.333997 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Jan 23 18:57:19.298475 ignition[546]: files: files passed Jan 23 18:57:19.336968 systemd[1]: Starting Ignition (record completion)... Jan 23 18:57:19.298481 ignition[546]: Ignition finished successfully Jan 23 18:57:19.385000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.385000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.356537 systemd[1]: Starting Reload Configuration from the Real Root... Jan 23 18:57:19.374693 systemd-networkd[345]: eth0: Gained IPv6LL Jan 23 18:57:19.378760 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 23 18:57:19.379663 systemd[1]: Finished Ignition (record completion). Jan 23 18:57:19.404480 systemd[1]: Reloading. Jan 23 18:57:19.430000 audit: BPF prog-id=3 op=UNLOAD Jan 23 18:57:19.431000 audit: BPF prog-id=6 op=UNLOAD Jan 23 18:57:19.433000 audit: BPF prog-id=9 op=UNLOAD Jan 23 18:57:19.437000 audit: BPF prog-id=10 op=UNLOAD Jan 23 18:57:19.540000 audit: BPF prog-id=11 op=LOAD Jan 23 18:57:19.540000 audit: BPF prog-id=12 op=LOAD Jan 23 18:57:19.540000 audit: BPF prog-id=13 op=LOAD Jan 23 18:57:19.540000 audit: BPF prog-id=4 op=UNLOAD Jan 23 18:57:19.540000 audit: BPF prog-id=5 op=UNLOAD Jan 23 18:57:19.541000 audit: BPF prog-id=14 op=LOAD Jan 23 18:57:19.541000 audit: BPF prog-id=15 op=LOAD Jan 23 18:57:19.541000 audit: BPF prog-id=16 op=LOAD Jan 23 18:57:19.541000 audit: BPF prog-id=7 op=UNLOAD Jan 23 18:57:19.541000 audit: BPF prog-id=8 op=UNLOAD Jan 23 18:57:19.542000 audit: BPF prog-id=17 op=LOAD Jan 23 18:57:19.545000 audit: BPF prog-id=18 op=LOAD Jan 23 18:57:19.564940 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 23 18:57:19.565075 systemd[1]: Finished Reload Configuration from the Real Root. Jan 23 18:57:19.570000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.570000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.571168 systemd[1]: Reached target Initrd File Systems. Jan 23 18:57:19.577669 systemd[1]: Reached target Initrd Default Target. Jan 23 18:57:19.583136 systemd[1]: Condition check resulted in dracut mount hook being skipped. Jan 23 18:57:19.584298 systemd[1]: Starting dracut pre-pivot and cleanup hook... Jan 23 18:57:19.602869 systemd[1]: Finished dracut pre-pivot and cleanup hook. Jan 23 18:57:19.605000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.608102 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Jan 23 18:57:19.621639 systemd[1]: Stopped target Host and Network Name Lookups. Jan 23 18:57:19.625170 systemd[1]: Stopped target Remote Encrypted Volumes. Jan 23 18:57:19.631132 systemd[1]: Stopped target Timer Units. Jan 23 18:57:19.639000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.633960 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 23 18:57:19.634137 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Jan 23 18:57:19.639759 systemd[1]: Stopped target Initrd Default Target. Jan 23 18:57:19.645929 systemd[1]: Stopped target Basic System. Jan 23 18:57:19.652608 systemd[1]: Stopped target Initrd Root Device. Jan 23 18:57:19.658387 systemd[1]: Stopped target Path Units. Jan 23 18:57:19.663479 systemd[1]: Stopped target Remote File Systems. Jan 23 18:57:19.668467 systemd[1]: Stopped target Preparation for Remote File Systems. Jan 23 18:57:19.674009 systemd[1]: Stopped target Slice Units. Jan 23 18:57:19.678706 systemd[1]: Stopped target Socket Units. Jan 23 18:57:19.683986 systemd[1]: Stopped target System Initialization. Jan 23 18:57:19.689596 systemd[1]: Stopped target Local File Systems. Jan 23 18:57:19.694365 systemd[1]: Stopped target Preparation for Local File Systems. Jan 23 18:57:19.710000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.699899 systemd[1]: Stopped target Swaps. Jan 23 18:57:19.707016 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 23 18:57:19.707361 systemd[1]: Stopped dracut pre-mount hook. Jan 23 18:57:19.711418 systemd[1]: Stopped target Local Encrypted Volumes. Jan 23 18:57:19.729000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.734761 iscsid[456]: iscsid shutting down. Jan 23 18:57:19.716868 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 23 18:57:19.720540 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Jan 23 18:57:19.753000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.725168 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 23 18:57:19.760000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.725429 systemd[1]: Stopped dracut initqueue hook. Jan 23 18:57:19.766000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.730278 systemd[1]: Stopping Open-iSCSI... Jan 23 18:57:19.736817 systemd[1]: Stopping /sysroot/boot... Jan 23 18:57:19.782000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.738674 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 23 18:57:19.789000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.789000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.738903 systemd[1]: Stopped Coldplug All udev Devices. Jan 23 18:57:19.795000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.753516 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 23 18:57:19.753676 systemd[1]: Stopped dracut pre-trigger hook. Jan 23 18:57:19.763295 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 23 18:57:19.763985 systemd[1]: iscsid.service: Deactivated successfully. Jan 23 18:57:19.821000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.764124 systemd[1]: Stopped Open-iSCSI. Jan 23 18:57:19.767408 systemd[1]: iscsid.socket: Deactivated successfully. Jan 23 18:57:19.767518 systemd[1]: Closed Open-iSCSI iscsid Socket. Jan 23 18:57:19.832000 audit: BPF prog-id=18 op=UNLOAD Jan 23 18:57:19.771666 systemd[1]: Stopping iSCSI UserSpace I/O driver... Jan 23 18:57:19.777227 systemd[1]: iscsiuio.service: Deactivated successfully. Jan 23 18:57:19.840000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.777517 systemd[1]: Stopped iSCSI UserSpace I/O driver. Jan 23 18:57:19.783201 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 23 18:57:19.783410 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Jan 23 18:57:19.790414 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 23 18:57:19.790528 systemd[1]: Stopped /sysroot/boot. Jan 23 18:57:19.861000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.797285 systemd[1]: Stopped target Network. Jan 23 18:57:19.802594 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 23 18:57:19.876000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.802678 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Jan 23 18:57:19.808588 systemd[1]: Stopping Network Name Resolution... Jan 23 18:57:19.881000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.815208 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 23 18:57:19.887000 audit: BPF prog-id=14 op=UNLOAD Jan 23 18:57:19.815427 systemd[1]: Stopped Network Name Resolution. Jan 23 18:57:19.896000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.901000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.822099 systemd[1]: Stopping Network Configuration... Jan 23 18:57:19.823778 systemd-networkd[345]: eth0: DHCP lease lost Jan 23 18:57:19.908000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.833010 systemd-networkd[345]: eth0: DHCPv6 lease lost Jan 23 18:57:19.915000 audit: BPF prog-id=17 op=UNLOAD Jan 23 18:57:19.835770 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 23 18:57:19.835971 systemd[1]: Stopped Network Configuration. Jan 23 18:57:19.924000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.842064 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 23 18:57:19.842105 systemd[1]: Closed Network Service Netlink Socket. Jan 23 18:57:19.850593 systemd[1]: Stopping Network Cleanup... Jan 23 18:57:19.858596 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 23 18:57:19.937000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:19.858670 systemd[1]: Stopped Apply Kernel Variables. Jan 23 18:57:19.861616 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Jan 23 18:57:19.870895 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 23 18:57:19.871097 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Jan 23 18:57:19.877508 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 23 18:57:19.877641 systemd[1]: Stopped Network Cleanup. Jan 23 18:57:19.881682 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 23 18:57:19.881735 systemd[1]: Closed udev Control Socket. Jan 23 18:57:19.886470 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 23 18:57:19.886509 systemd[1]: Closed udev Kernel Socket. Jan 23 18:57:19.889049 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 23 18:57:19.889104 systemd[1]: Stopped dracut pre-udev hook. Jan 23 18:57:19.896148 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 23 18:57:19.896194 systemd[1]: Stopped dracut cmdline hook. Jan 23 18:57:19.901989 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 23 18:57:19.902046 systemd[1]: Stopped dracut ask for additional cmdline parameters. Jan 23 18:57:19.910060 systemd[1]: Starting Cleanup udev Database... Jan 23 18:57:19.912967 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Jan 23 18:57:19.916410 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 23 18:57:19.918617 systemd[1]: Stopped Create Static Device Nodes in /dev. Jan 23 18:57:19.927299 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 23 18:57:19.932203 systemd[1]: Stopped Create List of Static Device Nodes. Jan 23 18:57:19.940674 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 23 18:57:19.940725 systemd[1]: Stopped Setup Virtual Console. Jan 23 18:57:20.005000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:20.006383 systemd[1]: rngd.service: Deactivated successfully. Jan 23 18:57:20.006574 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Jan 23 18:57:20.016000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=rngd comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:20.017181 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 23 18:57:20.017400 systemd[1]: Finished Cleanup udev Database. Jan 23 18:57:20.026000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:20.026000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:20.027141 systemd[1]: Reached target Switch Root. Jan 23 18:57:20.035091 systemd[1]: Starting Switch Root... Jan 23 18:57:20.051312 systemd[1]: Switching root. Jan 23 18:57:20.054000 audit: BPF prog-id=11 op=UNLOAD Jan 23 18:57:20.068734 systemd-journald[192]: Journal stopped Jan 23 18:57:28.389979 systemd-journald[192]: Received SIGTERM from PID 1 (n/a). Jan 23 18:57:28.390043 kernel: SELinux: policy capability network_peer_controls=1 Jan 23 18:57:28.390062 kernel: SELinux: policy capability open_perms=1 Jan 23 18:57:28.390076 kernel: SELinux: policy capability extended_socket_class=1 Jan 23 18:57:28.390089 kernel: SELinux: policy capability always_check_network=0 Jan 23 18:57:28.390104 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 23 18:57:28.390118 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 23 18:57:28.390133 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 23 18:57:28.390149 systemd[1]: Successfully loaded SELinux policy in 59.261ms. Jan 23 18:57:28.390174 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.668ms. Jan 23 18:57:28.390190 systemd[1]: systemd 249 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 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Jan 23 18:57:28.390206 systemd[1]: Detected virtualization kvm. Jan 23 18:57:28.390221 systemd[1]: Detected architecture x86-64. Jan 23 18:57:28.390236 systemd[1]: Detected first boot. Jan 23 18:57:28.390251 systemd[1]: Initializing machine ID from VM UUID. Jan 23 18:57:28.390266 systemd[1]: Populated /etc with preset unit settings. Jan 23 18:57:28.390283 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. Jan 23 18:57:28.390298 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jan 23 18:57:28.390312 kernel: kauditd_printk_skb: 76 callbacks suppressed Jan 23 18:57:28.390390 kernel: audit: type=1334 audit(1769194647.870:95): prog-id=21 op=LOAD Jan 23 18:57:28.390406 kernel: audit: type=1334 audit(1769194647.877:96): prog-id=22 op=LOAD Jan 23 18:57:28.390421 kernel: audit: type=1334 audit(1769194647.881:97): prog-id=23 op=LOAD Jan 23 18:57:28.390435 kernel: audit: type=1334 audit(1769194647.881:98): prog-id=12 op=UNLOAD Jan 23 18:57:28.390446 kernel: audit: type=1334 audit(1769194647.881:99): prog-id=13 op=UNLOAD Jan 23 18:57:28.390458 kernel: audit: type=1334 audit(1769194647.885:100): prog-id=24 op=LOAD Jan 23 18:57:28.390470 kernel: audit: type=1334 audit(1769194647.885:101): prog-id=21 op=UNLOAD Jan 23 18:57:28.390483 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 23 18:57:28.390499 kernel: audit: type=1334 audit(1769194647.889:102): prog-id=25 op=LOAD Jan 23 18:57:28.390513 systemd[1]: Stopped Switch Root. Jan 23 18:57:28.390524 kernel: audit: type=1334 audit(1769194647.896:103): prog-id=26 op=LOAD Jan 23 18:57:28.390541 kernel: audit: type=1334 audit(1769194647.896:104): prog-id=22 op=UNLOAD Jan 23 18:57:28.390554 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 23 18:57:28.390568 systemd[1]: Created slice Slice /system/addon-config. Jan 23 18:57:28.390580 systemd[1]: Created slice Slice /system/addon-run. Jan 23 18:57:28.390592 systemd[1]: Created slice Slice /system/getty. Jan 23 18:57:28.390604 systemd[1]: Created slice Slice /system/modprobe. Jan 23 18:57:28.390618 systemd[1]: Created slice Slice /system/serial-getty. Jan 23 18:57:28.390634 systemd[1]: Created slice Slice /system/system-cloudinit. Jan 23 18:57:28.390650 systemd[1]: Created slice Slice /system/systemd-fsck. Jan 23 18:57:28.390667 systemd[1]: Created slice User and Session Slice. Jan 23 18:57:28.390679 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Jan 23 18:57:28.390693 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Jan 23 18:57:28.390706 systemd[1]: Set up automount Boot partition Automount Point. Jan 23 18:57:28.390718 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Jan 23 18:57:28.390732 systemd[1]: Stopped target Switch Root. Jan 23 18:57:28.390743 systemd[1]: Stopped target Initrd File Systems. Jan 23 18:57:28.390756 systemd[1]: Stopped target Initrd Root File System. Jan 23 18:57:28.390769 systemd[1]: Reached target Remote Encrypted Volumes. Jan 23 18:57:28.390786 systemd[1]: Reached target Remote File Systems. Jan 23 18:57:28.390799 systemd[1]: Reached target Slice Units. Jan 23 18:57:28.390812 systemd[1]: Reached target Swaps. Jan 23 18:57:28.390824 systemd[1]: Reached target Verify torcx succeeded. Jan 23 18:57:28.390836 systemd[1]: Reached target Local Verity Protected Volumes. Jan 23 18:57:28.390849 systemd[1]: Listening on Process Core Dump Socket. Jan 23 18:57:28.390861 systemd[1]: Listening on initctl Compatibility Named Pipe. Jan 23 18:57:28.390874 systemd[1]: Listening on Network Service Netlink Socket. Jan 23 18:57:28.390888 systemd[1]: Listening on udev Control Socket. Jan 23 18:57:28.390899 systemd[1]: Listening on udev Kernel Socket. Jan 23 18:57:28.390948 systemd[1]: Mounting Huge Pages File System... Jan 23 18:57:28.390965 systemd[1]: Mounting POSIX Message Queue File System... Jan 23 18:57:28.390977 systemd[1]: Mounting External Media Directory... Jan 23 18:57:28.390996 systemd[1]: Condition check resulted in /proc/xen being skipped. Jan 23 18:57:28.391009 systemd[1]: Mounting Kernel Debug File System... Jan 23 18:57:28.391022 systemd[1]: Mounting Kernel Trace File System... Jan 23 18:57:28.391035 systemd[1]: Mounting Temporary Directory /tmp... Jan 23 18:57:28.391049 systemd[1]: Starting Create missing system files... Jan 23 18:57:28.391061 systemd[1]: Starting Create List of Static Device Nodes... Jan 23 18:57:28.391072 systemd[1]: Starting Load Kernel Module configfs... Jan 23 18:57:28.391087 systemd[1]: Starting Load Kernel Module drm... Jan 23 18:57:28.391101 systemd[1]: Starting Load Kernel Module fuse... Jan 23 18:57:28.391112 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Jan 23 18:57:28.391126 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 23 18:57:28.391139 systemd[1]: Stopped File System Check on Root Device. Jan 23 18:57:28.391150 kernel: fuse: init (API version 7.32) Jan 23 18:57:28.391163 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 23 18:57:28.391175 systemd[1]: Stopped systemd-fsck-usr.service. Jan 23 18:57:28.391187 systemd[1]: Stopped Journal Service. Jan 23 18:57:28.391203 systemd[1]: Starting Journal Service... Jan 23 18:57:28.391217 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Jan 23 18:57:28.391231 systemd[1]: Starting Remount Root and Kernel File Systems... Jan 23 18:57:28.391243 systemd[1]: Starting Apply Kernel Variables... Jan 23 18:57:28.391256 systemd[1]: Starting Coldplug All udev Devices... Jan 23 18:57:28.391269 systemd[1]: verity-setup.service: Deactivated successfully. Jan 23 18:57:28.391283 systemd[1]: Stopped verity-setup.service. Jan 23 18:57:28.391296 systemd[1]: Condition check resulted in Set fake PV driver version for XenServer being skipped. Jan 23 18:57:28.391309 systemd[1]: Mounted Huge Pages File System. Jan 23 18:57:28.391400 systemd[1]: Mounted POSIX Message Queue File System. Jan 23 18:57:28.391422 systemd[1]: Mounted External Media Directory. Jan 23 18:57:28.391440 systemd-journald[765]: Journal started Jan 23 18:57:28.391486 systemd-journald[765]: Runtime Journal (/run/log/journal/5e5260523bc446b5ba731d0adb20d8da) is 6.0M, max 48.7M, 42.6M free. Jan 23 18:57:20.252000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 23 18:57:20.339000 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 Jan 23 18:57:20.339000 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 Jan 23 18:57:20.340000 audit: BPF prog-id=19 op=LOAD Jan 23 18:57:20.340000 audit: BPF prog-id=19 op=UNLOAD Jan 23 18:57:20.340000 audit: BPF prog-id=20 op=LOAD Jan 23 18:57:20.340000 audit: BPF prog-id=20 op=UNLOAD Jan 23 18:57:20.454000 audit[710]: AVC avc: denied { associate } for pid=710 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 Jan 23 18:57:27.870000 audit: BPF prog-id=21 op=LOAD Jan 23 18:57:27.877000 audit: BPF prog-id=22 op=LOAD Jan 23 18:57:27.881000 audit: BPF prog-id=23 op=LOAD Jan 23 18:57:27.881000 audit: BPF prog-id=12 op=UNLOAD Jan 23 18:57:27.881000 audit: BPF prog-id=13 op=UNLOAD Jan 23 18:57:27.885000 audit: BPF prog-id=24 op=LOAD Jan 23 18:57:27.885000 audit: BPF prog-id=21 op=UNLOAD Jan 23 18:57:27.889000 audit: BPF prog-id=25 op=LOAD Jan 23 18:57:27.896000 audit: BPF prog-id=26 op=LOAD Jan 23 18:57:27.896000 audit: BPF prog-id=22 op=UNLOAD Jan 23 18:57:27.896000 audit: BPF prog-id=23 op=UNLOAD Jan 23 18:57:27.898000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:27.924000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:27.924000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:27.936000 audit: BPF prog-id=24 op=UNLOAD Jan 23 18:57:28.281000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.295000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.301000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.301000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.313000 audit: BPF prog-id=27 op=LOAD Jan 23 18:57:28.314000 audit: BPF prog-id=28 op=LOAD Jan 23 18:57:28.315000 audit: BPF prog-id=29 op=LOAD Jan 23 18:57:28.316000 audit: BPF prog-id=25 op=UNLOAD Jan 23 18:57:28.316000 audit: BPF prog-id=26 op=UNLOAD Jan 23 18:57:28.361000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.388000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Jan 23 18:57:27.855220 systemd[1]: Queued start job for default target Multi-User System. Jan 23 18:57:20.436445 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" 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/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Jan 23 18:57:27.897770 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 23 18:57:20.439141 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Jan 23 18:57:20.439176 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Jan 23 18:57:20.439806 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Jan 23 18:57:20.439822 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=debug msg="skipped missing lower profile" missing profile=oem Jan 23 18:57:20.439896 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Jan 23 18:57:20.439915 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Jan 23 18:57:20.440171 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Jan 23 18:57:20.440217 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Jan 23 18:57:20.440233 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Jan 23 18:57:20.442761 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" 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 Jan 23 18:57:20.442812 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" 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 Jan 23 18:57:20.443096 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3033.2.4: no such file or directory" path=/usr/share/oem/torcx/store/3033.2.4 Jan 23 18:57:20.443115 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Jan 23 18:57:20.443138 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3033.2.4: no such file or directory" path=/var/lib/torcx/store/3033.2.4 Jan 23 18:57:20.443153 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:20Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Jan 23 18:57:27.530652 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:27Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Jan 23 18:57:27.531187 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:27Z" 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 Jan 23 18:57:27.531297 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:27Z" 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 Jan 23 18:57:27.531536 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:27Z" 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]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Jan 23 18:57:27.531622 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:27Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Jan 23 18:57:27.531688 /usr/lib64/systemd/system-generators/torcx-generator[710]: time="2026-01-23T18:57:27Z" 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 Jan 23 18:57:28.400033 systemd[1]: Started Journal Service. Jan 23 18:57:28.400000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.400898 systemd[1]: Mounted Kernel Debug File System. Jan 23 18:57:28.404099 systemd[1]: Mounted Kernel Trace File System. Jan 23 18:57:28.406643 systemd[1]: Mounted Temporary Directory /tmp. Jan 23 18:57:28.409881 systemd[1]: Finished Create missing system files. Jan 23 18:57:28.412000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.413654 systemd[1]: Finished Create List of Static Device Nodes. Jan 23 18:57:28.416000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.417183 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 23 18:57:28.417502 systemd[1]: Finished Load Kernel Module configfs. Jan 23 18:57:28.419000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.419000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.427733 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 23 18:57:28.427964 systemd[1]: Finished Load Kernel Module drm. Jan 23 18:57:28.430000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.430000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.430860 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 23 18:57:28.431248 systemd[1]: Finished Load Kernel Module fuse. Jan 23 18:57:28.434000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.434000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.435404 systemd[1]: Finished Remount Root and Kernel File Systems. Jan 23 18:57:28.439000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.440078 systemd[1]: Finished Apply Kernel Variables. Jan 23 18:57:28.443000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.446003 systemd[1]: Mounting FUSE Control File System... Jan 23 18:57:28.449968 systemd[1]: Mounting Kernel Configuration File System... Jan 23 18:57:28.452557 systemd[1]: Condition check resulted in Remount Root File System being skipped. Jan 23 18:57:28.454469 systemd[1]: Starting Rebuild Hardware Database... Jan 23 18:57:28.457826 systemd[1]: Starting Flush Journal to Persistent Storage... Jan 23 18:57:28.460741 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Jan 23 18:57:28.461856 systemd[1]: Starting Load/Save Random Seed... Jan 23 18:57:28.466955 systemd-journald[765]: Time spent on flushing to /var/log/journal/5e5260523bc446b5ba731d0adb20d8da is 14.897ms for 988 entries. Jan 23 18:57:28.466955 systemd-journald[765]: System Journal (/var/log/journal/5e5260523bc446b5ba731d0adb20d8da) is 8.0M, max 203.0M, 195.0M free. Jan 23 18:57:28.488000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.493000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.466556 systemd[1]: Starting Create System Users... Jan 23 18:57:28.476857 systemd[1]: Mounted FUSE Control File System. Jan 23 18:57:28.481267 systemd[1]: Mounted Kernel Configuration File System. Jan 23 18:57:28.485606 systemd[1]: Finished Coldplug All udev Devices. Jan 23 18:57:28.489820 systemd[1]: Finished Load/Save Random Seed. Jan 23 18:57:28.494820 systemd[1]: Reached target First Boot Complete. Jan 23 18:57:28.501387 systemd[1]: Starting Wait for udev To Complete Device Initialization... Jan 23 18:57:28.505141 systemd[1]: Finished Flush Journal to Persistent Storage. Jan 23 18:57:28.508000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.510745 systemd-sysusers[777]: Creating group sgx with gid 999. Jan 23 18:57:28.512201 systemd-sysusers[777]: Creating group systemd-oom with gid 998. Jan 23 18:57:28.513428 systemd-sysusers[777]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Jan 23 18:57:28.516135 systemd-sysusers[777]: Creating group systemd-timesync with gid 997. Jan 23 18:57:28.517069 systemd-sysusers[777]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Jan 23 18:57:28.519527 systemd-sysusers[777]: Creating group systemd-coredump with gid 996. Jan 23 18:57:28.520664 systemd-sysusers[777]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Jan 23 18:57:28.543616 systemd[1]: Finished Create System Users. Jan 23 18:57:28.546000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:28.551600 systemd[1]: Starting Create Static Device Nodes in /dev... Jan 23 18:57:28.596280 systemd[1]: Finished Create Static Device Nodes in /dev. Jan 23 18:57:28.599000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:30.837760 systemd[1]: Finished Rebuild Hardware Database. Jan 23 18:57:30.844000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:30.868000 audit: BPF prog-id=30 op=LOAD Jan 23 18:57:30.871000 audit: BPF prog-id=31 op=LOAD Jan 23 18:57:30.873000 audit: BPF prog-id=32 op=LOAD Jan 23 18:57:30.875000 audit: BPF prog-id=15 op=UNLOAD Jan 23 18:57:30.875000 audit: BPF prog-id=16 op=UNLOAD Jan 23 18:57:30.877179 systemd[1]: Starting Rule-based Manager for Device Events and Files... Jan 23 18:57:31.106464 systemd[1]: Started Rule-based Manager for Device Events and Files. Jan 23 18:57:31.110000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:31.117000 audit: BPF prog-id=33 op=LOAD Jan 23 18:57:31.119617 systemd[1]: Starting Network Configuration... Jan 23 18:57:31.141392 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Jan 23 18:57:31.159656 kernel: ACPI: Power Button [PWRF] Jan 23 18:57:31.163757 systemd-udevd[795]: Using default interface naming scheme 'v249'. Jan 23 18:57:31.194000 audit[798]: AVC avc: denied { confidentiality } for pid=798 comm="systemd-udevd" 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 Jan 23 18:57:31.202276 systemd-networkd[791]: lo: Link UP Jan 23 18:57:31.202284 systemd-networkd[791]: lo: Gained carrier Jan 23 18:57:31.206000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:31.203133 systemd-networkd[791]: Enumeration completed Jan 23 18:57:31.203277 systemd[1]: Started Network Configuration. Jan 23 18:57:31.208605 systemd-networkd[791]: eth0: Link UP Jan 23 18:57:31.214464 systemd-networkd[791]: eth0: Gained carrier Jan 23 18:57:31.220532 systemd-networkd[791]: eth0: DHCPv4 address 10.0.0.4/16 via 10.0.0.1 Jan 23 18:57:31.265390 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jan 23 18:57:31.267620 udevadm[781]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jan 23 18:57:31.279407 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Jan 23 18:57:31.279534 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jan 23 18:57:31.332111 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Jan 23 18:57:31.418889 kernel: mousedev: PS/2 mouse device common for all mice Jan 23 18:57:31.464579 kernel: kvm: Nested Virtualization enabled Jan 23 18:57:31.467980 kernel: SVM: kvm: Nested Paging enabled Jan 23 18:57:31.468015 kernel: SVM: Virtual VMLOAD VMSAVE supported Jan 23 18:57:31.497171 kernel: EDAC MC: Ver: 3.0.0 Jan 23 18:57:31.685285 systemd[1]: Finished Wait for udev To Complete Device Initialization. Jan 23 18:57:31.689000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:31.700137 systemd[1]: Starting Activation of LVM2 logical volumes... Jan 23 18:57:31.776667 lvm[814]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 23 18:57:31.868438 systemd[1]: Finished Activation of LVM2 logical volumes. Jan 23 18:57:31.873000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:31.874987 systemd[1]: Reached target Local Encrypted Volumes. Jan 23 18:57:31.889380 systemd[1]: Starting Activation of LVM2 logical volumes... Jan 23 18:57:31.897066 lvm[815]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 23 18:57:31.920983 systemd[1]: Finished Activation of LVM2 logical volumes. Jan 23 18:57:31.925000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:31.925525 systemd[1]: Reached target Preparation for Local File Systems. Jan 23 18:57:31.931732 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Jan 23 18:57:31.931782 systemd[1]: Reached target Containers. Jan 23 18:57:31.941013 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Jan 23 18:57:31.978674 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Jan 23 18:57:31.982000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:31.989715 systemd[1]: Mounting /usr/share/oem... Jan 23 18:57:32.006478 kernel: BTRFS info (device vda6): disk space caching is enabled Jan 23 18:57:32.006574 kernel: BTRFS info (device vda6): has skinny extents Jan 23 18:57:32.019572 systemd[1]: Mounted /usr/share/oem. Jan 23 18:57:32.023171 systemd[1]: Reached target Local File Systems. Jan 23 18:57:32.072859 systemd[1]: Starting Rebuild Dynamic Linker Cache... Jan 23 18:57:32.079043 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jan 23 18:57:32.079156 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Jan 23 18:57:32.082259 systemd[1]: Starting Commit a transient machine-id on disk... Jan 23 18:57:32.105447 systemd[1]: Starting Create Volatile Files and Directories... Jan 23 18:57:32.155788 systemd-tmpfiles[840]: /usr/lib64/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Jan 23 18:57:32.156844 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 23 18:57:32.157892 systemd[1]: Finished Commit a transient machine-id on disk. Jan 23 18:57:32.162000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:32.162873 systemd-tmpfiles[840]: /usr/lib64/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Jan 23 18:57:32.222840 systemd-tmpfiles[840]: Detected autofs mount point /boot during canonicalization of /boot. Jan 23 18:57:32.222875 systemd-tmpfiles[840]: Skipping /boot Jan 23 18:57:32.230135 systemd-tmpfiles[840]: Detected autofs mount point /boot during canonicalization of /boot. Jan 23 18:57:32.230178 systemd-tmpfiles[840]: Skipping /boot Jan 23 18:57:32.233479 systemd-networkd[791]: eth0: Gained IPv6LL Jan 23 18:57:32.291895 systemd[1]: Finished Create Volatile Files and Directories. Jan 23 18:57:32.295000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:32.308514 systemd[1]: Starting Load Security Auditing Rules... Jan 23 18:57:32.314135 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Jan 23 18:57:32.318912 systemd[1]: Starting Rebuild Journal Catalog... Jan 23 18:57:32.324451 systemd[1]: Starting Network Name Resolution... Jan 23 18:57:32.322000 audit: BPF prog-id=34 op=LOAD Jan 23 18:57:32.328000 audit: BPF prog-id=35 op=LOAD Jan 23 18:57:32.329481 systemd[1]: Starting Network Time Synchronization... Jan 23 18:57:32.334800 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Jan 23 18:57:32.340416 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Jan 23 18:57:32.352000 audit[847]: SYSTEM_BOOT pid=847 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib64/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' Jan 23 18:57:32.354000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:32.357304 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Jan 23 18:57:32.362161 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Jan 23 18:57:32.365000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:32.366554 systemd[1]: Finished Rebuild Journal Catalog. Jan 23 18:57:32.370000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:32.472121 systemd[1]: Started Network Time Synchronization. Jan 23 18:57:32.478000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-timesyncd comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:32.479508 systemd[1]: Reached target System Time Set. Jan 23 18:57:32.480239 augenrules[863]: No rules Jan 23 18:57:32.479000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Jan 23 18:57:32.487838 systemd[1]: Finished Load Security Auditing Rules. Jan 23 18:57:33.242275 systemd-timesyncd[846]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Jan 23 18:57:33.247774 systemd-resolved[845]: Positive Trust Anchors: Jan 23 18:57:33.247809 systemd-resolved[845]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 23 18:57:33.247846 systemd-resolved[845]: 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 Jan 23 18:57:33.250255 systemd-resolved[845]: Defaulting to hostname 'linux'. Jan 23 18:57:33.262904 systemd[1]: Started Network Name Resolution. Jan 23 18:57:33.269117 systemd[1]: Reached target Network. Jan 23 18:57:33.274106 systemd[1]: Reached target Host and Network Name Lookups. Jan 23 18:57:33.884093 systemd[1]: Finished Rebuild Dynamic Linker Cache. Jan 23 18:57:33.900115 systemd[1]: Starting Update is Completed... Jan 23 18:57:33.924679 systemd[1]: Finished Update is Completed. Jan 23 18:57:33.928731 systemd[1]: Reached target System Initialization. Jan 23 18:57:33.932851 systemd[1]: Started Watch for update engine configuration changes. Jan 23 18:57:33.936421 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jan 23 18:57:33.940286 systemd[1]: Started Daily Log Rotation. Jan 23 18:57:33.942748 systemd[1]: Started Weekly check for MD array's redundancy information.. Jan 23 18:57:33.946153 systemd[1]: Started Daily Cleanup of Temporary Directories. Jan 23 18:57:33.948887 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Jan 23 18:57:33.949011 systemd[1]: Reached target Path Units. Jan 23 18:57:33.951706 systemd[1]: Reached target Timer Units. Jan 23 18:57:33.954508 systemd[1]: Listening on D-Bus System Message Bus Socket. Jan 23 18:57:33.960424 systemd[1]: Starting Docker Socket for the API... Jan 23 18:57:33.967466 systemd[1]: Listening on OpenSSH Server Socket. Jan 23 18:57:33.971553 systemd[1]: Listening on Docker Socket for the API. Jan 23 18:57:33.974763 systemd[1]: Reached target Socket Units. Jan 23 18:57:33.977276 systemd[1]: Reached target Basic System. Jan 23 18:57:33.980265 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Jan 23 18:57:33.980329 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Jan 23 18:57:33.983382 systemd[1]: Started D-Bus System Message Bus. Jan 23 18:57:33.990019 systemd[1]: Starting Extend Filesystems... Jan 23 18:57:33.993282 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Jan 23 18:57:33.995186 systemd[1]: Starting Generate /run/flatcar/motd... Jan 23 18:57:34.027028 systemd[1]: Starting Install an ssh key from /proc/cmdline... Jan 23 18:57:34.041398 systemd[1]: Starting Generate sshd host keys... Jan 23 18:57:34.045897 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Jan 23 18:57:34.045992 systemd[1]: Reached target Load system-provided cloud configs. Jan 23 18:57:34.067520 systemd[1]: Starting User Login Management... Jan 23 18:57:34.072296 systemd[1]: Condition check resulted in TCG Core Services Daemon being skipped. Jan 23 18:57:34.089450 extend-filesystems[873]: Found sr0 Jan 23 18:57:34.089450 extend-filesystems[873]: Found vda Jan 23 18:57:34.089450 extend-filesystems[873]: Found vda1 Jan 23 18:57:34.089450 extend-filesystems[873]: Found vda2 Jan 23 18:57:34.089450 extend-filesystems[873]: Found vda3 Jan 23 18:57:34.089450 extend-filesystems[873]: Found usr Jan 23 18:57:34.089450 extend-filesystems[873]: Found vda4 Jan 23 18:57:34.089450 extend-filesystems[873]: Found vda6 Jan 23 18:57:34.089450 extend-filesystems[873]: Found vda7 Jan 23 18:57:34.089450 extend-filesystems[873]: Found vda9 Jan 23 18:57:34.089450 extend-filesystems[873]: Checking size of /dev/vda9 Jan 23 18:57:34.091339 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 23 18:57:34.271160 extend-filesystems[873]: Old size kept for /dev/vda9 Jan 23 18:57:34.093422 systemd[1]: Starting Update Engine... Jan 23 18:57:34.108365 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Jan 23 18:57:34.108546 systemd[1]: Reached target Load user-provided cloud configs. Jan 23 18:57:34.126707 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 23 18:57:34.127549 systemd[1]: Finished Install an ssh key from /proc/cmdline. Jan 23 18:57:34.142922 systemd[1]: motdgen.service: Deactivated successfully. Jan 23 18:57:34.144725 systemd[1]: Finished Generate /run/flatcar/motd. Jan 23 18:57:34.162100 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 23 18:57:34.162469 systemd[1]: Finished Extend Filesystems. Jan 23 18:57:34.321886 systemd-logind[883]: Watching system buttons on /dev/input/event1 (Power Button) Jan 23 18:57:34.322070 systemd-logind[883]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jan 23 18:57:34.324323 systemd-logind[883]: New seat seat0. Jan 23 18:57:34.332085 systemd[1]: Started User Login Management. Jan 23 18:57:34.395199 update_engine[889]: I0123 18:57:34.393568 889 main.cc:89] Flatcar Update Engine starting Jan 23 18:57:34.635868 systemd[1]: Started Update Engine. Jan 23 18:57:34.638562 update_engine[889]: I0123 18:57:34.637177 889 update_check_scheduler.cc:74] Next update check in 3m44s Jan 23 18:57:34.662317 sshd_keygen[891]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Jan 23 18:57:34.674214 systemd[1]: Started Cluster reboot manager. Jan 23 18:57:34.702363 systemd[1]: Finished Generate sshd host keys. Jan 23 18:57:34.717535 systemd[1]: Starting Generate /run/issue... Jan 23 18:57:34.728083 systemd[1]: issuegen.service: Deactivated successfully. Jan 23 18:57:34.728380 systemd[1]: Finished Generate /run/issue. Jan 23 18:57:34.733535 systemd[1]: Starting Permit User Sessions... Jan 23 18:57:34.746737 systemd[1]: Finished Permit User Sessions. Jan 23 18:57:34.752302 systemd[1]: Started Getty on tty1. Jan 23 18:57:34.756792 systemd[1]: Started Serial Getty on ttyS0. Jan 23 18:57:34.760475 systemd[1]: Reached target Login Prompts. Jan 23 18:57:34.763980 systemd[1]: Reached target Multi-User System. Jan 23 18:57:34.776576 systemd[1]: Starting Record Runlevel Change in UTMP... Jan 23 18:57:34.793163 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Jan 23 18:57:34.793546 systemd[1]: Finished Record Runlevel Change in UTMP. Jan 23 18:57:34.800418 systemd[1]: Startup finished in 4.185s (kernel) + 4.517s (initrd) + 13.863s (userspace) = 22.566s. Jan 23 18:57:34.859348 locksmithd[900]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 23 18:57:42.934000 systemd[1]: Created slice Slice /system/sshd. Jan 23 18:57:42.935705 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34828). Jan 23 18:57:43.021751 sshd[917]: Accepted publickey for core from 10.0.0.1 port 34828 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:43.024736 sshd[917]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:43.050626 systemd[1]: Created slice User Slice of UID 500. Jan 23 18:57:43.052274 systemd[1]: Starting User Runtime Directory /run/user/500... Jan 23 18:57:43.061925 systemd-logind[883]: New session 1 of user core. Jan 23 18:57:43.074385 systemd[1]: Finished User Runtime Directory /run/user/500. Jan 23 18:57:43.082661 systemd[1]: Starting User Manager for UID 500... Jan 23 18:57:43.091337 systemd[920]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:43.194988 systemd[920]: Queued start job for default target Main User Target. Jan 23 18:57:43.195211 systemd[920]: Reached target Paths. Jan 23 18:57:43.195229 systemd[920]: Reached target Sockets. Jan 23 18:57:43.195244 systemd[920]: Reached target Timers. Jan 23 18:57:43.195259 systemd[920]: Reached target Basic System. Jan 23 18:57:43.195785 systemd[920]: Reached target Main User Target. Jan 23 18:57:43.195801 systemd[920]: Startup finished in 87ms. Jan 23 18:57:43.195848 systemd[1]: Started User Manager for UID 500. Jan 23 18:57:43.201038 systemd[1]: Started Session 1 of User core. Jan 23 18:57:43.288584 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34838). Jan 23 18:57:43.342670 sshd[929]: Accepted publickey for core from 10.0.0.1 port 34838 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:43.344336 sshd[929]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:43.353297 systemd-logind[883]: New session 2 of user core. Jan 23 18:57:43.361277 systemd[1]: Started Session 2 of User core. Jan 23 18:57:43.443327 sshd[929]: pam_unix(sshd:session): session closed for user core Jan 23 18:57:43.453452 systemd[1]: sshd@1-10.0.0.4:22-10.0.0.1:34838.service: Deactivated successfully. Jan 23 18:57:43.454407 systemd[1]: session-2.scope: Deactivated successfully. Jan 23 18:57:43.455428 systemd-logind[883]: Session 2 logged out. Waiting for processes to exit. Jan 23 18:57:43.456660 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34850). Jan 23 18:57:43.457823 systemd-logind[883]: Removed session 2. Jan 23 18:57:43.503710 sshd[935]: Accepted publickey for core from 10.0.0.1 port 34850 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:43.505062 sshd[935]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:43.509638 systemd-logind[883]: New session 3 of user core. Jan 23 18:57:43.519553 systemd[1]: Started Session 3 of User core. Jan 23 18:57:43.580922 sshd[935]: pam_unix(sshd:session): session closed for user core Jan 23 18:57:43.587288 systemd[1]: sshd@2-10.0.0.4:22-10.0.0.1:34850.service: Deactivated successfully. Jan 23 18:57:43.588345 systemd[1]: session-3.scope: Deactivated successfully. Jan 23 18:57:43.589444 systemd-logind[883]: Session 3 logged out. Waiting for processes to exit. Jan 23 18:57:43.590840 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34852). Jan 23 18:57:43.592456 systemd-logind[883]: Removed session 3. Jan 23 18:57:43.633272 sshd[941]: Accepted publickey for core from 10.0.0.1 port 34852 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:43.635306 sshd[941]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:43.640545 systemd-logind[883]: New session 4 of user core. Jan 23 18:57:43.646206 systemd[1]: Started Session 4 of User core. Jan 23 18:57:43.720291 sshd[941]: pam_unix(sshd:session): session closed for user core Jan 23 18:57:43.730657 systemd[1]: sshd@3-10.0.0.4:22-10.0.0.1:34852.service: Deactivated successfully. Jan 23 18:57:43.731435 systemd[1]: session-4.scope: Deactivated successfully. Jan 23 18:57:43.733886 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34854). Jan 23 18:57:43.736857 systemd-logind[883]: Session 4 logged out. Waiting for processes to exit. Jan 23 18:57:43.738629 systemd-logind[883]: Removed session 4. Jan 23 18:57:43.773879 sshd[947]: Accepted publickey for core from 10.0.0.1 port 34854 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:43.775106 sshd[947]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:43.781910 systemd-logind[883]: New session 5 of user core. Jan 23 18:57:43.790589 systemd[1]: Started Session 5 of User core. Jan 23 18:57:43.874209 sudo[950]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Jan 23 18:57:43.874473 sudo[950]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jan 23 18:57:43.888723 sudo[950]: pam_unix(sudo:session): session closed for user root Jan 23 18:57:43.893264 sshd[947]: pam_unix(sshd:session): session closed for user core Jan 23 18:57:43.906738 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34866). Jan 23 18:57:43.910848 dbus-daemon[872]: [system] Reloaded configuration Jan 23 18:57:43.915036 systemd[1]: sshd@4-10.0.0.4:22-10.0.0.1:34854.service: Deactivated successfully. Jan 23 18:57:43.916085 systemd[1]: session-5.scope: Deactivated successfully. Jan 23 18:57:43.917065 systemd-logind[883]: Session 5 logged out. Waiting for processes to exit. Jan 23 18:57:43.918528 systemd-logind[883]: Removed session 5. Jan 23 18:57:43.953212 sshd[953]: Accepted publickey for core from 10.0.0.1 port 34866 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:43.954418 sshd[953]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:43.960410 systemd-logind[883]: New session 6 of user core. Jan 23 18:57:43.965155 systemd[1]: Started Session 6 of User core. Jan 23 18:57:44.028549 sudo[958]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Jan 23 18:57:44.028806 sudo[958]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jan 23 18:57:44.040865 sudo[958]: pam_unix(sudo:session): session closed for user root Jan 23 18:57:44.047803 sudo[957]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Jan 23 18:57:44.048185 sudo[957]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jan 23 18:57:44.067439 systemd[1]: Stopping Load Security Auditing Rules... Jan 23 18:57:44.070000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Jan 23 18:57:44.073031 auditctl[961]: No rules Jan 23 18:57:44.072866 systemd[1]: audit-rules.service: Deactivated successfully. Jan 23 18:57:44.073725 systemd[1]: Stopped Load Security Auditing Rules. Jan 23 18:57:44.074606 kernel: kauditd_printk_skb: 56 callbacks suppressed Jan 23 18:57:44.074647 kernel: audit: type=1305 audit(1769194664.070:161): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Jan 23 18:57:44.076164 systemd[1]: Starting Load Security Auditing Rules... Jan 23 18:57:44.070000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:44.099155 kernel: audit: type=1131 audit(1769194664.070: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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:44.119879 augenrules[978]: No rules Jan 23 18:57:44.120879 systemd[1]: Finished Load Security Auditing Rules. Jan 23 18:57:44.120000 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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:44.122067 sudo[957]: pam_unix(sudo:session): session closed for user root Jan 23 18:57:44.124668 sshd[953]: pam_unix(sshd:session): session closed for user core Jan 23 18:57:44.121000 audit[957]: USER_END pid=957 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' Jan 23 18:57:44.151775 kernel: audit: type=1130 audit(1769194664.120: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/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:44.151842 kernel: audit: type=1106 audit(1769194664.121:164): pid=957 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' Jan 23 18:57:44.151865 kernel: audit: type=1104 audit(1769194664.121:165): pid=957 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' Jan 23 18:57:44.121000 audit[957]: CRED_DISP pid=957 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' Jan 23 18:57:44.154018 systemd[1]: sshd@5-10.0.0.4:22-10.0.0.1:34866.service: Deactivated successfully. Jan 23 18:57:44.154545 systemd[1]: session-6.scope: Deactivated successfully. Jan 23 18:57:44.155740 systemd-logind[883]: Session 6 logged out. Waiting for processes to exit. Jan 23 18:57:44.156199 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34876). Jan 23 18:57:44.157166 systemd-logind[883]: Removed session 6. Jan 23 18:57:44.125000 audit[953]: USER_END pid=953 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' Jan 23 18:57:44.180591 kernel: audit: type=1106 audit(1769194664.125:166): pid=953 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' Jan 23 18:57:44.181200 kernel: audit: type=1104 audit(1769194664.125:167): pid=953 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' Jan 23 18:57:44.125000 audit[953]: CRED_DISP pid=953 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' Jan 23 18:57:44.193864 sshd[984]: Accepted publickey for core from 10.0.0.1 port 34876 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:44.153000 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.4:22-10.0.0.1:34866 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:44.196439 sshd[984]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:44.212302 systemd-logind[883]: New session 7 of user core. Jan 23 18:57:44.212867 kernel: audit: type=1131 audit(1769194664.153:168): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.0.0.4:22-10.0.0.1:34866 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:44.213034 kernel: audit: type=1130 audit(1769194664.155:169): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.4:22-10.0.0.1:34876 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:44.155000 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.4:22-10.0.0.1:34876 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:44.213093 systemd[1]: Started Session 7 of User core. Jan 23 18:57:44.192000 audit[984]: USER_ACCT pid=984 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' Jan 23 18:57:44.239722 kernel: audit: type=1101 audit(1769194664.192:170): pid=984 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' Jan 23 18:57:44.194000 audit[984]: CRED_ACQ pid=984 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' Jan 23 18:57:44.220000 audit[984]: USER_START pid=984 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' Jan 23 18:57:44.222000 audit[986]: CRED_ACQ pid=986 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' Jan 23 18:57:44.271000 audit[987]: USER_ACCT pid=987 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' Jan 23 18:57:44.272997 sudo[987]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/mkdir -p . Jan 23 18:57:44.272000 audit[987]: CRED_REFR pid=987 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' Jan 23 18:57:44.273242 sudo[987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jan 23 18:57:44.274000 audit[987]: USER_START pid=987 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' Jan 23 18:57:44.277905 sudo[987]: pam_unix(sudo:session): session closed for user root Jan 23 18:57:44.278000 audit[987]: USER_END pid=987 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' Jan 23 18:57:44.278000 audit[987]: CRED_DISP pid=987 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' Jan 23 18:57:44.282112 sshd[984]: pam_unix(sshd:session): session closed for user core Jan 23 18:57:44.283000 audit[984]: USER_END pid=984 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' Jan 23 18:57:44.283000 audit[984]: CRED_DISP pid=984 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' Jan 23 18:57:44.290413 systemd[1]: sshd@6-10.0.0.4:22-10.0.0.1:34876.service: Deactivated successfully. Jan 23 18:57:44.289000 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.4:22-10.0.0.1:34876 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:44.291363 systemd[1]: session-7.scope: Deactivated successfully. Jan 23 18:57:44.292996 systemd-logind[883]: Session 7 logged out. Waiting for processes to exit. Jan 23 18:57:44.294105 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34882). Jan 23 18:57:44.293000 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.4:22-10.0.0.1:34882 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:44.295106 systemd-logind[883]: Removed session 7. Jan 23 18:57:44.335928 sshd[991]: Accepted publickey for core from 10.0.0.1 port 34882 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:44.334000 audit[991]: USER_ACCT pid=991 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' Jan 23 18:57:44.336000 audit[991]: CRED_ACQ pid=991 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' Jan 23 18:57:44.337663 sshd[991]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:44.345797 systemd-logind[883]: New session 8 of user core. Jan 23 18:57:44.352352 systemd[1]: Started Session 8 of User core. Jan 23 18:57:44.361000 audit[991]: USER_START pid=991 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' Jan 23 18:57:44.362000 audit[993]: CRED_ACQ pid=993 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' Jan 23 18:57:44.421000 audit[994]: USER_ACCT pid=994 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' Jan 23 18:57:44.421000 audit[994]: CRED_REFR pid=994 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' Jan 23 18:57:44.422408 sudo[994]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/install -m 0755 /dev/stdin kolet Jan 23 18:57:44.422757 sudo[994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jan 23 18:57:44.424000 audit[994]: USER_START pid=994 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' Jan 23 18:57:45.892279 sudo[994]: pam_unix(sudo:session): session closed for user root Jan 23 18:57:45.891000 audit[994]: USER_END pid=994 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' Jan 23 18:57:45.891000 audit[994]: CRED_DISP pid=994 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' Jan 23 18:57:45.895139 sshd[991]: pam_unix(sshd:session): session closed for user core Jan 23 18:57:45.906000 audit[991]: USER_END pid=991 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' Jan 23 18:57:45.906000 audit[991]: CRED_DISP pid=991 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' Jan 23 18:57:45.911246 systemd[1]: sshd@7-10.0.0.4:22-10.0.0.1:34882.service: Deactivated successfully. Jan 23 18:57:45.910000 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.4:22-10.0.0.1:34882 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:45.912119 systemd[1]: session-8.scope: Deactivated successfully. Jan 23 18:57:45.912432 systemd[1]: session-8.scope: Consumed 1.623s CPU time. Jan 23 18:57:45.913661 systemd-logind[883]: Session 8 logged out. Waiting for processes to exit. Jan 23 18:57:45.914737 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:60874). Jan 23 18:57:45.913000 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.4:22-10.0.0.1:60874 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:45.915802 systemd-logind[883]: Removed session 8. Jan 23 18:57:45.955000 audit[998]: USER_ACCT pid=998 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' Jan 23 18:57:45.956583 sshd[998]: Accepted publickey for core from 10.0.0.1 port 60874 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:45.956000 audit[998]: CRED_ACQ pid=998 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' Jan 23 18:57:45.958183 sshd[998]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:45.967625 systemd-logind[883]: New session 9 of user core. Jan 23 18:57:45.971259 systemd[1]: Started Session 9 of User core. Jan 23 18:57:45.991000 audit[998]: USER_START pid=998 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' Jan 23 18:57:45.995000 audit[1000]: CRED_ACQ pid=1000 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' Jan 23 18:57:46.046000 audit[1001]: USER_ACCT pid=1001 uid=500 auid=500 ses=9 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' Jan 23 18:57:46.047000 audit[1001]: CRED_REFR pid=1001 uid=500 auid=500 ses=9 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' Jan 23 18:57:46.047870 sudo[1001]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/mkdir -p /updates Jan 23 18:57:46.048215 sudo[1001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jan 23 18:57:46.049000 audit[1001]: USER_START pid=1001 uid=500 auid=500 ses=9 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' Jan 23 18:57:46.052803 sudo[1001]: pam_unix(sudo:session): session closed for user root Jan 23 18:57:46.051000 audit[1001]: USER_END pid=1001 uid=500 auid=500 ses=9 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' Jan 23 18:57:46.052000 audit[1001]: CRED_DISP pid=1001 uid=500 auid=500 ses=9 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' Jan 23 18:57:46.055907 sshd[998]: pam_unix(sshd:session): session closed for user core Jan 23 18:57:46.056000 audit[998]: USER_END pid=998 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' Jan 23 18:57:46.057000 audit[998]: CRED_DISP pid=998 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' Jan 23 18:57:46.064276 systemd[1]: sshd@8-10.0.0.4:22-10.0.0.1:60874.service: Deactivated successfully. Jan 23 18:57:46.063000 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.4:22-10.0.0.1:60874 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:46.065233 systemd[1]: session-9.scope: Deactivated successfully. Jan 23 18:57:46.066359 systemd-logind[883]: Session 9 logged out. Waiting for processes to exit. Jan 23 18:57:46.067685 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:60878). Jan 23 18:57:46.066000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@9-10.0.0.4:22-10.0.0.1:60878 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:46.069362 systemd-logind[883]: Removed session 9. Jan 23 18:57:46.108000 audit[1005]: USER_ACCT pid=1005 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' Jan 23 18:57:46.109551 sshd[1005]: Accepted publickey for core from 10.0.0.1 port 60878 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:46.109000 audit[1005]: CRED_ACQ pid=1005 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' Jan 23 18:57:46.110823 sshd[1005]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:46.116074 systemd-logind[883]: New session 10 of user core. Jan 23 18:57:46.125593 systemd[1]: Started Session 10 of User core. Jan 23 18:57:46.144000 audit[1005]: USER_START pid=1005 uid=0 auid=500 ses=10 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' Jan 23 18:57:46.146000 audit[1007]: CRED_ACQ pid=1007 uid=0 auid=500 ses=10 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' Jan 23 18:57:46.227000 audit[1008]: USER_ACCT pid=1008 uid=500 auid=500 ses=10 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' Jan 23 18:57:46.229000 audit[1008]: CRED_REFR pid=1008 uid=500 auid=500 ses=10 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' Jan 23 18:57:46.228873 sudo[1008]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/install -m 0755 /dev/stdin /updates/update.gz Jan 23 18:57:46.230221 sudo[1008]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jan 23 18:57:46.232000 audit[1008]: USER_START pid=1008 uid=500 auid=500 ses=10 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' Jan 23 18:57:59.852674 sudo[1008]: pam_unix(sudo:session): session closed for user root Jan 23 18:57:59.851000 audit[1008]: USER_END pid=1008 uid=500 auid=500 ses=10 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' Jan 23 18:57:59.856145 kernel: kauditd_printk_skb: 49 callbacks suppressed Jan 23 18:57:59.856202 kernel: audit: type=1106 audit(1769194679.851:220): pid=1008 uid=500 auid=500 ses=10 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' Jan 23 18:57:59.851000 audit[1008]: CRED_DISP pid=1008 uid=500 auid=500 ses=10 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' Jan 23 18:57:59.872256 sshd[1005]: pam_unix(sshd:session): session closed for user core Jan 23 18:57:59.935591 kernel: audit: type=1104 audit(1769194679.851:221): pid=1008 uid=500 auid=500 ses=10 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' Jan 23 18:57:59.935638 kernel: audit: type=1106 audit(1769194679.873:222): pid=1005 uid=0 auid=500 ses=10 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' Jan 23 18:57:59.935667 kernel: audit: type=1104 audit(1769194679.873:223): pid=1005 uid=0 auid=500 ses=10 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' Jan 23 18:57:59.873000 audit[1005]: USER_END pid=1005 uid=0 auid=500 ses=10 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' Jan 23 18:57:59.873000 audit[1005]: CRED_DISP pid=1005 uid=0 auid=500 ses=10 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' Jan 23 18:57:59.937638 systemd[1]: sshd@9-10.0.0.4:22-10.0.0.1:60878.service: Deactivated successfully. Jan 23 18:57:59.937000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@9-10.0.0.4:22-10.0.0.1:60878 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:59.938507 systemd[1]: session-10.scope: Deactivated successfully. Jan 23 18:57:59.938747 systemd[1]: session-10.scope: Consumed 16.707s CPU time. Jan 23 18:57:59.939501 systemd-logind[883]: Session 10 logged out. Waiting for processes to exit. Jan 23 18:57:59.941010 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38616). Jan 23 18:57:59.942311 systemd-logind[883]: Removed session 10. Jan 23 18:57:59.940000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@10-10.0.0.4:22-10.0.0.1:38616 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:59.972564 kernel: audit: type=1131 audit(1769194679.937:224): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@9-10.0.0.4:22-10.0.0.1:60878 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:59.972691 kernel: audit: type=1130 audit(1769194679.940:225): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@10-10.0.0.4:22-10.0.0.1:38616 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:57:59.984864 sshd[1012]: Accepted publickey for core from 10.0.0.1 port 38616 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:57:59.983000 audit[1012]: USER_ACCT pid=1012 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' Jan 23 18:57:59.987436 sshd[1012]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:57:59.992013 systemd-logind[883]: New session 11 of user core. Jan 23 18:57:59.986000 audit[1012]: CRED_ACQ pid=1012 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' Jan 23 18:58:00.028913 kernel: audit: type=1101 audit(1769194679.983:226): pid=1012 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' Jan 23 18:58:00.029055 kernel: audit: type=1103 audit(1769194679.986:227): pid=1012 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' Jan 23 18:58:00.029078 kernel: audit: type=1006 audit(1769194679.986:228): pid=1012 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=11 res=1 Jan 23 18:58:00.044374 systemd[1]: Started Session 11 of User core. Jan 23 18:58:00.056000 audit[1012]: USER_START pid=1012 uid=0 auid=500 ses=11 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' Jan 23 18:58:00.058000 audit[1014]: CRED_ACQ pid=1014 uid=0 auid=500 ses=11 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' Jan 23 18:58:00.076037 kernel: audit: type=1105 audit(1769194680.056:229): pid=1012 uid=0 auid=500 ses=11 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' Jan 23 18:58:00.118000 audit[1015]: USER_ACCT pid=1015 uid=500 auid=500 ses=11 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' Jan 23 18:58:00.119267 sudo[1015]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemd-run --quiet ./kolet run cl.update.docker-btrfs-compat Omaha Jan 23 18:58:00.118000 audit[1015]: CRED_REFR pid=1015 uid=500 auid=500 ses=11 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' Jan 23 18:58:00.119524 sudo[1015]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jan 23 18:58:00.124000 audit[1015]: USER_START pid=1015 uid=500 auid=500 ses=11 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' Jan 23 18:58:00.148000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=run-rd4db177f83624521ad367746dd2e982f comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:58:00.149630 systemd[1]: Started /home/core/./kolet run cl.update.docker-btrfs-compat Omaha. Jan 23 18:58:00.150779 sudo[1015]: pam_unix(sudo:session): session closed for user root Jan 23 18:58:00.149000 audit[1015]: USER_END pid=1015 uid=500 auid=500 ses=11 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' Jan 23 18:58:00.150000 audit[1015]: CRED_DISP pid=1015 uid=500 auid=500 ses=11 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' Jan 23 18:58:00.152782 sshd[1012]: pam_unix(sshd:session): session closed for user core Jan 23 18:58:00.153000 audit[1012]: USER_END pid=1012 uid=0 auid=500 ses=11 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' Jan 23 18:58:00.153000 audit[1012]: CRED_DISP pid=1012 uid=0 auid=500 ses=11 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' Jan 23 18:58:00.156506 systemd[1]: sshd@10-10.0.0.4:22-10.0.0.1:38616.service: Deactivated successfully. Jan 23 18:58:00.155000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@10-10.0.0.4:22-10.0.0.1:38616 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:58:00.157323 systemd[1]: session-11.scope: Deactivated successfully. Jan 23 18:58:00.158718 systemd-logind[883]: Session 11 logged out. Waiting for processes to exit. Jan 23 18:58:00.160072 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38628). Jan 23 18:58:00.159000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@11-10.0.0.4:22-10.0.0.1:38628 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:58:00.163436 systemd-logind[883]: Removed session 11. Jan 23 18:58:00.227000 audit[1024]: USER_ACCT pid=1024 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' Jan 23 18:58:00.229000 audit[1024]: CRED_ACQ pid=1024 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' Jan 23 18:58:00.230326 sshd[1024]: Accepted publickey for core from 10.0.0.1 port 38628 ssh2: RSA SHA256:pKT939SvPTQKTziY3v9t6cn5iyJwS86ta+5CXRx6STU Jan 23 18:58:00.230522 sshd[1024]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jan 23 18:58:00.236646 systemd-logind[883]: New session 12 of user core. Jan 23 18:58:00.243381 systemd[1]: Started Session 12 of User core. Jan 23 18:58:00.251000 audit[1024]: USER_START pid=1024 uid=0 auid=500 ses=12 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' Jan 23 18:58:00.253000 audit[1027]: CRED_ACQ pid=1027 uid=0 auid=500 ses=12 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' Jan 23 18:58:03.305666 sshd[1024]: pam_unix(sshd:session): session closed for user core Jan 23 18:58:03.307000 audit[1024]: USER_END pid=1024 uid=0 auid=500 ses=12 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' Jan 23 18:58:03.307000 audit[1024]: CRED_DISP pid=1024 uid=0 auid=500 ses=12 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' Jan 23 18:58:03.310763 systemd[1]: sshd@11-10.0.0.4:22-10.0.0.1:38628.service: Deactivated successfully. Jan 23 18:58:03.310000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@11-10.0.0.4:22-10.0.0.1:38628 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jan 23 18:58:03.312296 systemd[1]: session-12.scope: Deactivated successfully. Jan 23 18:58:03.313291 systemd-logind[883]: Session 12 logged out. Waiting for processes to exit. Jan 23 18:58:03.314412 systemd-logind[883]: Removed session 12. Jan 23 18:58:20.255076 update_engine[889]: I0123 18:58:20.254104 889 update_attempter.cc:505] Updating boot flags... Jan 23 19:01:19.337152 update_engine[889]: I0123 19:01:19.336501 889 prefs.cc:51] certificate-report-to-send-update not present in /var/lib/update_engine/prefs Jan 23 19:01:19.337152 update_engine[889]: I0123 19:01:19.336824 889 prefs.cc:51] certificate-report-to-send-download not present in /var/lib/update_engine/prefs Jan 23 19:01:19.342416 update_engine[889]: I0123 19:01:19.339437 889 prefs.cc:51] aleph-version not present in /var/lib/update_engine/prefs Jan 23 19:01:19.342416 update_engine[889]: I0123 19:01:19.340469 889 omaha_request_params.cc:62] Current group set to stable Jan 23 19:01:19.342416 update_engine[889]: I0123 19:01:19.341915 889 update_attempter.cc:495] Already updated boot flags. Skipping. Jan 23 19:01:19.342416 update_engine[889]: I0123 19:01:19.341926 889 update_attempter.cc:638] Scheduling an action processor start. Jan 23 19:01:19.342416 update_engine[889]: I0123 19:01:19.341996 889 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Jan 23 19:01:19.342416 update_engine[889]: I0123 19:01:19.342106 889 prefs.cc:51] previous-version not present in /var/lib/update_engine/prefs Jan 23 19:01:19.342416 update_engine[889]: I0123 19:01:19.342231 889 omaha_request_action.cc:268] Posting an Omaha request to disabled Jan 23 19:01:19.342416 update_engine[889]: I0123 19:01:19.342242 889 omaha_request_action.cc:269] Request: Jan 23 19:01:19.342416 update_engine[889]: Jan 23 19:01:19.342416 update_engine[889]: Jan 23 19:01:19.342416 update_engine[889]: Jan 23 19:01:19.342416 update_engine[889]: Jan 23 19:01:19.342416 update_engine[889]: Jan 23 19:01:19.342416 update_engine[889]: Jan 23 19:01:19.342416 update_engine[889]: Jan 23 19:01:19.342416 update_engine[889]: Jan 23 19:01:19.342416 update_engine[889]: I0123 19:01:19.342279 889 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Jan 23 19:01:19.346147 locksmithd[900]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0 Jan 23 19:01:19.350580 update_engine[889]: I0123 19:01:19.350512 889 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Jan 23 19:01:19.351469 update_engine[889]: I0123 19:01:19.351418 889 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Jan 23 19:01:19.387658 update_engine[889]: E0123 19:01:19.387555 889 libcurl_http_fetcher.cc:251] Unable to get http response code: Could not resolve host: disabled Jan 23 19:01:19.387800 update_engine[889]: I0123 19:01:19.387701 889 libcurl_http_fetcher.cc:268] No HTTP response, retry 1 Jan 23 19:01:29.245818 update_engine[889]: I0123 19:01:29.245198 889 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Jan 23 19:01:29.245818 update_engine[889]: I0123 19:01:29.245669 889 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Jan 23 19:01:29.247063 update_engine[889]: I0123 19:01:29.246060 889 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Jan 23 19:01:29.249529 update_engine[889]: E0123 19:01:29.249468 889 libcurl_http_fetcher.cc:251] Unable to get http response code: Could not resolve host: disabled Jan 23 19:01:29.249598 update_engine[889]: I0123 19:01:29.249544 889 libcurl_http_fetcher.cc:268] No HTTP response, retry 2 Jan 23 19:01:39.246528 update_engine[889]: I0123 19:01:39.246083 889 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Jan 23 19:01:39.246528 update_engine[889]: I0123 19:01:39.246537 889 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Jan 23 19:01:39.247793 update_engine[889]: I0123 19:01:39.246922 889 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Jan 23 19:01:39.251227 update_engine[889]: E0123 19:01:39.250989 889 libcurl_http_fetcher.cc:251] Unable to get http response code: Could not resolve host: disabled Jan 23 19:01:39.251227 update_engine[889]: I0123 19:01:39.251060 889 libcurl_http_fetcher.cc:268] No HTTP response, retry 3 Jan 23 19:01:49.248834 update_engine[889]: I0123 19:01:49.246330 889 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Jan 23 19:01:49.248834 update_engine[889]: I0123 19:01:49.248123 889 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Jan 23 19:01:49.250632 update_engine[889]: I0123 19:01:49.250429 889 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Jan 23 19:01:49.253562 update_engine[889]: E0123 19:01:49.252722 889 libcurl_http_fetcher.cc:251] Unable to get http response code: Could not resolve host: disabled Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.252794 889 libcurl_http_fetcher.cc:282] Transfer resulted in an error (0), 0 bytes downloaded Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.252802 889 omaha_request_action.cc:619] Omaha request response: Jan 23 19:01:49.253562 update_engine[889]: E0123 19:01:49.252805 889 omaha_request_action.cc:633] Omaha request network transfer failed. Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.252874 889 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaRequestAction action failed. Aborting processing. Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.252880 889 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.252883 889 update_attempter.cc:302] Processing Done. Jan 23 19:01:49.253562 update_engine[889]: E0123 19:01:49.253006 889 update_attempter.cc:615] Update failed. Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.253054 889 utils.cc:600] Converting error code 2000 to kActionCodeOmahaErrorInHTTPResponse Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.253060 889 payload_state.cc:97] Updating payload state for error code: 37 (kActionCodeOmahaErrorInHTTPResponse) Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.253064 889 payload_state.cc:103] Ignoring failures until we get a valid Omaha response. Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.253186 889 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.253212 889 omaha_request_action.cc:268] Posting an Omaha request to disabled Jan 23 19:01:49.253562 update_engine[889]: I0123 19:01:49.253218 889 omaha_request_action.cc:269] Request: Jan 23 19:01:49.253562 update_engine[889]: Jan 23 19:01:49.253562 update_engine[889]: Jan 23 19:01:49.253562 update_engine[889]: Jan 23 19:01:49.254258 update_engine[889]: Jan 23 19:01:49.254258 update_engine[889]: Jan 23 19:01:49.254258 update_engine[889]: Jan 23 19:01:49.254258 update_engine[889]: I0123 19:01:49.253222 889 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Jan 23 19:01:49.254258 update_engine[889]: I0123 19:01:49.253268 889 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Jan 23 19:01:49.254258 update_engine[889]: I0123 19:01:49.253389 889 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Jan 23 19:01:49.254412 locksmithd[900]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_REPORTING_ERROR_EVENT" NewVersion=0.0.0 NewSize=0 Jan 23 19:01:49.255759 update_engine[889]: E0123 19:01:49.255414 889 libcurl_http_fetcher.cc:251] Unable to get http response code: Could not resolve host: disabled Jan 23 19:01:49.255759 update_engine[889]: I0123 19:01:49.255515 889 libcurl_http_fetcher.cc:282] Transfer resulted in an error (0), 0 bytes downloaded Jan 23 19:01:49.255759 update_engine[889]: I0123 19:01:49.255524 889 omaha_request_action.cc:619] Omaha request response: Jan 23 19:01:49.255759 update_engine[889]: I0123 19:01:49.255532 889 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jan 23 19:01:49.255759 update_engine[889]: I0123 19:01:49.255534 889 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jan 23 19:01:49.255759 update_engine[889]: I0123 19:01:49.255537 889 update_attempter.cc:302] Processing Done. Jan 23 19:01:49.255759 update_engine[889]: I0123 19:01:49.255541 889 update_attempter.cc:306] Error event sent. Jan 23 19:01:49.255759 update_engine[889]: I0123 19:01:49.255597 889 update_check_scheduler.cc:74] Next update check in 49m33s Jan 23 19:01:49.257720 locksmithd[900]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_IDLE" NewVersion=0.0.0 NewSize=0