Sep 3 14:32:21.763778 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 Sep 3 14:32:21.763795 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 Sep 3 14:32:21.763802 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Sep 3 14:32:21.763807 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Sep 3 14:32:21.763811 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Sep 3 14:32:21.763816 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Sep 3 14:32:21.763821 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Sep 3 14:32:21.763826 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Sep 3 14:32:21.763831 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Sep 3 14:32:21.763836 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Sep 3 14:32:21.763840 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Sep 3 14:32:21.763844 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Sep 3 14:32:21.763849 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format. Sep 3 14:32:21.763853 kernel: BIOS-provided physical RAM map: Sep 3 14:32:21.763859 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Sep 3 14:32:21.763866 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Sep 3 14:32:21.763870 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Sep 3 14:32:21.763875 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Sep 3 14:32:21.763879 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Sep 3 14:32:21.763884 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Sep 3 14:32:21.763888 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Sep 3 14:32:21.763893 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Sep 3 14:32:21.763905 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Sep 3 14:32:21.763910 kernel: NX (Execute Disable) protection: active Sep 3 14:32:21.763914 kernel: SMBIOS 2.8 present. Sep 3 14:32:21.763919 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Sep 3 14:32:21.763925 kernel: Hypervisor detected: KVM Sep 3 14:32:21.763929 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Sep 3 14:32:21.763934 kernel: kvm-clock: cpu 0, msr 786ba001, primary cpu clock Sep 3 14:32:21.763939 kernel: kvm-clock: using sched offset of 4931937535 cycles Sep 3 14:32:21.763944 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 3 14:32:21.763949 kernel: tsc: Detected 2793.438 MHz processor Sep 3 14:32:21.763954 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 3 14:32:21.763959 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 3 14:32:21.763964 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x10000000000 Sep 3 14:32:21.763969 kernel: MTRR default type: write-back Sep 3 14:32:21.763975 kernel: MTRR fixed ranges enabled: Sep 3 14:32:21.763980 kernel: 00000-9FFFF write-back Sep 3 14:32:21.763984 kernel: A0000-BFFFF uncachable Sep 3 14:32:21.763988 kernel: C0000-FFFFF write-protect Sep 3 14:32:21.763994 kernel: MTRR variable ranges enabled: Sep 3 14:32:21.763999 kernel: 0 base 0000C0000000 mask 3FFFC0000000 uncachable Sep 3 14:32:21.764003 kernel: 1 disabled Sep 3 14:32:21.764008 kernel: 2 disabled Sep 3 14:32:21.764012 kernel: 3 disabled Sep 3 14:32:21.764017 kernel: 4 disabled Sep 3 14:32:21.764021 kernel: 5 disabled Sep 3 14:32:21.764025 kernel: 6 disabled Sep 3 14:32:21.764029 kernel: 7 disabled Sep 3 14:32:21.764034 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 3 14:32:21.764038 kernel: Using GB pages for direct mapping Sep 3 14:32:21.764049 kernel: ACPI: Early table checksum verification disabled Sep 3 14:32:21.764054 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Sep 3 14:32:21.764059 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 3 14:32:21.764063 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 3 14:32:21.764068 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 3 14:32:21.764073 kernel: ACPI: FACS 0x000000009CFE0000 000040 Sep 3 14:32:21.764077 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 3 14:32:21.764082 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 3 14:32:21.764086 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 3 14:32:21.764090 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 3 14:32:21.764095 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Sep 3 14:32:21.764100 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Sep 3 14:32:21.764105 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Sep 3 14:32:21.764109 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Sep 3 14:32:21.764113 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Sep 3 14:32:21.764117 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Sep 3 14:32:21.764122 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Sep 3 14:32:21.764126 kernel: ACPI: Local APIC address 0xfee00000 Sep 3 14:32:21.764136 kernel: No NUMA configuration found Sep 3 14:32:21.764141 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Sep 3 14:32:21.764145 kernel: NODE_DATA(0) allocated [mem 0x9cfd6000-0x9cfdbfff] Sep 3 14:32:21.764151 kernel: Zone ranges: Sep 3 14:32:21.764155 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 3 14:32:21.764160 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Sep 3 14:32:21.764164 kernel: Normal empty Sep 3 14:32:21.764168 kernel: Movable zone start for each node Sep 3 14:32:21.764173 kernel: Early memory node ranges Sep 3 14:32:21.764177 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Sep 3 14:32:21.764181 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Sep 3 14:32:21.764186 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Sep 3 14:32:21.764190 kernel: On node 0 totalpages: 642938 Sep 3 14:32:21.764195 kernel: DMA zone: 64 pages used for memmap Sep 3 14:32:21.764200 kernel: DMA zone: 21 pages reserved Sep 3 14:32:21.764204 kernel: DMA zone: 3998 pages, LIFO batch:0 Sep 3 14:32:21.764208 kernel: DMA32 zone: 9984 pages used for memmap Sep 3 14:32:21.764212 kernel: DMA32 zone: 638940 pages, LIFO batch:63 Sep 3 14:32:21.764217 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 3 14:32:21.764221 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Sep 3 14:32:21.764225 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Sep 3 14:32:21.764230 kernel: ACPI: PM-Timer IO Port: 0x608 Sep 3 14:32:21.764236 kernel: ACPI: Local APIC address 0xfee00000 Sep 3 14:32:21.764240 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Sep 3 14:32:21.764245 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Sep 3 14:32:21.764249 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Sep 3 14:32:21.764267 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Sep 3 14:32:21.764271 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 3 14:32:21.764275 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Sep 3 14:32:21.764279 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Sep 3 14:32:21.764284 kernel: ACPI: IRQ0 used by override. Sep 3 14:32:21.764288 kernel: ACPI: IRQ5 used by override. Sep 3 14:32:21.764294 kernel: ACPI: IRQ9 used by override. Sep 3 14:32:21.764298 kernel: ACPI: IRQ10 used by override. Sep 3 14:32:21.764303 kernel: ACPI: IRQ11 used by override. Sep 3 14:32:21.764307 kernel: Using ACPI (MADT) for SMP configuration information Sep 3 14:32:21.764311 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Sep 3 14:32:21.764315 kernel: TSC deadline timer available Sep 3 14:32:21.764320 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Sep 3 14:32:21.764324 kernel: kvm-guest: KVM setup pv remote TLB flush Sep 3 14:32:21.764328 kernel: kvm-guest: setup PV sched yield Sep 3 14:32:21.764333 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Sep 3 14:32:21.764339 kernel: Booting paravirtualized kernel on KVM Sep 3 14:32:21.764343 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Sep 3 14:32:21.764347 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:4 nr_node_ids:1 Sep 3 14:32:21.764352 kernel: percpu: Embedded 58 pages/cpu s199704 r8192 d29672 u524288 Sep 3 14:32:21.764356 kernel: pcpu-alloc: s199704 r8192 d29672 u524288 alloc=1*2097152 Sep 3 14:32:21.764367 kernel: pcpu-alloc: [0] 0 1 2 3 Sep 3 14:32:21.764371 kernel: kvm-guest: KVM setup async PF for cpu 0 Sep 3 14:32:21.764381 kernel: kvm-guest: stealtime: cpu 0, msr 9a41c580 Sep 3 14:32:21.764393 kernel: kvm-guest: PV spinlocks enabled Sep 3 14:32:21.764398 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Sep 3 14:32:21.764403 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632869 Sep 3 14:32:21.764407 kernel: Policy zone: DMA32 Sep 3 14:32:21.764413 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 Sep 3 14:32:21.764418 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 3 14:32:21.764422 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 3 14:32:21.764429 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 3 14:32:21.764434 kernel: Memory: 2448560K/2571752K available (10246K kernel code, 2239K rwdata, 11640K rodata, 42228K init, 1436K bss, 122988K reserved, 0K cma-reserved) Sep 3 14:32:21.764438 kernel: random: get_random_u64 called from __kmem_cache_create+0x26/0x400 with crng_init=0 Sep 3 14:32:21.764443 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 3 14:32:21.764447 kernel: ftrace: allocating 34378 entries in 135 pages Sep 3 14:32:21.764452 kernel: ftrace: allocated 135 pages with 4 groups Sep 3 14:32:21.764456 kernel: rcu: Hierarchical RCU implementation. Sep 3 14:32:21.764461 kernel: rcu: RCU event tracing is enabled. Sep 3 14:32:21.764466 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 3 14:32:21.764470 kernel: Rude variant of Tasks RCU enabled. Sep 3 14:32:21.764477 kernel: Tracing variant of Tasks RCU enabled. Sep 3 14:32:21.764481 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 3 14:32:21.764486 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 3 14:32:21.764490 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Sep 3 14:32:21.764495 kernel: Console: colour VGA+ 80x25 Sep 3 14:32:21.764499 kernel: printk: console [ttyS0] enabled Sep 3 14:32:21.764504 kernel: ACPI: Core revision 20200925 Sep 3 14:32:21.764508 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Sep 3 14:32:21.764513 kernel: APIC: Switch to symmetric I/O mode setup Sep 3 14:32:21.764519 kernel: x2apic enabled Sep 3 14:32:21.764523 kernel: Switched APIC routing to physical x2apic. Sep 3 14:32:21.764528 kernel: kvm-guest: setup PV IPIs Sep 3 14:32:21.764532 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Sep 3 14:32:21.764537 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Sep 3 14:32:21.764541 kernel: Calibrating delay loop (skipped) preset value.. 5586.87 BogoMIPS (lpj=2793438) Sep 3 14:32:21.764546 kernel: pid_max: default: 32768 minimum: 301 Sep 3 14:32:21.764550 kernel: LSM: Security Framework initializing Sep 3 14:32:21.764556 kernel: SELinux: Initializing. Sep 3 14:32:21.764561 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 3 14:32:21.764565 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 3 14:32:21.764570 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Sep 3 14:32:21.764574 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Sep 3 14:32:21.764579 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Sep 3 14:32:21.764585 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 3 14:32:21.764590 kernel: Spectre V2 : Mitigation: Retpolines Sep 3 14:32:21.764594 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Sep 3 14:32:21.764605 kernel: Speculative Store Bypass: Vulnerable Sep 3 14:32:21.764609 kernel: Freeing SMP alternatives memory: 28K Sep 3 14:32:21.764614 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz (family: 0x6, model: 0x6a, stepping: 0x6) Sep 3 14:32:21.764619 kernel: Performance Events: unsupported p6 CPU model 106 no PMU driver, software events only. Sep 3 14:32:21.764623 kernel: rcu: Hierarchical SRCU implementation. Sep 3 14:32:21.764628 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Sep 3 14:32:21.764632 kernel: smp: Bringing up secondary CPUs ... Sep 3 14:32:21.764638 kernel: x86: Booting SMP configuration: Sep 3 14:32:21.764661 kernel: .... node #0, CPUs: #1 Sep 3 14:32:21.764666 kernel: kvm-clock: cpu 1, msr 786ba041, secondary cpu clock Sep 3 14:32:21.764670 kernel: kvm-guest: KVM setup async PF for cpu 1 Sep 3 14:32:21.764675 kernel: kvm-guest: stealtime: cpu 1, msr 9a49c580 Sep 3 14:32:21.764679 kernel: #2 Sep 3 14:32:21.764684 kernel: kvm-clock: cpu 2, msr 786ba081, secondary cpu clock Sep 3 14:32:21.764688 kernel: kvm-guest: KVM setup async PF for cpu 2 Sep 3 14:32:21.764693 kernel: kvm-guest: stealtime: cpu 2, msr 9a51c580 Sep 3 14:32:21.764699 kernel: #3 Sep 3 14:32:21.764703 kernel: kvm-clock: cpu 3, msr 786ba0c1, secondary cpu clock Sep 3 14:32:21.764708 kernel: kvm-guest: KVM setup async PF for cpu 3 Sep 3 14:32:21.764712 kernel: kvm-guest: stealtime: cpu 3, msr 9a59c580 Sep 3 14:32:21.764717 kernel: smp: Brought up 1 node, 4 CPUs Sep 3 14:32:21.764721 kernel: smpboot: Max logical packages: 1 Sep 3 14:32:21.764726 kernel: smpboot: Total of 4 processors activated (22347.50 BogoMIPS) Sep 3 14:32:21.764730 kernel: devtmpfs: initialized Sep 3 14:32:21.764735 kernel: x86/mm: Memory block size: 128MB Sep 3 14:32:21.764739 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 3 14:32:21.764745 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 3 14:32:21.764750 kernel: pinctrl core: initialized pinctrl subsystem Sep 3 14:32:21.764755 kernel: NET: Registered protocol family 16 Sep 3 14:32:21.764759 kernel: audit: initializing netlink subsys (disabled) Sep 3 14:32:21.764764 kernel: audit: type=2000 audit(1788445940.242:1): state=initialized audit_enabled=0 res=1 Sep 3 14:32:21.764768 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 3 14:32:21.764773 kernel: thermal_sys: Registered thermal governor 'user_space' Sep 3 14:32:21.764777 kernel: cpuidle: using governor menu Sep 3 14:32:21.764782 kernel: ACPI: bus type PCI registered Sep 3 14:32:21.764788 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 3 14:32:21.764792 kernel: dca service started, version 1.12.1 Sep 3 14:32:21.764797 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Sep 3 14:32:21.764802 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved in E820 Sep 3 14:32:21.764806 kernel: PCI: Using configuration type 1 for base access Sep 3 14:32:21.764811 kernel: Kprobes globally optimized Sep 3 14:32:21.764815 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Sep 3 14:32:21.764820 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Sep 3 14:32:21.764824 kernel: ACPI: Added _OSI(Module Device) Sep 3 14:32:21.764829 kernel: ACPI: Added _OSI(Processor Device) Sep 3 14:32:21.764835 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Sep 3 14:32:21.764839 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 3 14:32:21.764844 kernel: ACPI: Added _OSI(Linux-Dell-Video) Sep 3 14:32:21.764848 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Sep 3 14:32:21.764853 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Sep 3 14:32:21.764857 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 3 14:32:21.764862 kernel: ACPI: Interpreter enabled Sep 3 14:32:21.764866 kernel: ACPI: (supports S0 S3 S5) Sep 3 14:32:21.764870 kernel: ACPI: Using IOAPIC for interrupt routing Sep 3 14:32:21.764876 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 3 14:32:21.764881 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Sep 3 14:32:21.764886 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 3 14:32:21.765014 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 3 14:32:21.765074 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Sep 3 14:32:21.765120 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Sep 3 14:32:21.765126 kernel: PCI host bridge to bus 0000:00 Sep 3 14:32:21.765189 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Sep 3 14:32:21.765235 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Sep 3 14:32:21.765291 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Sep 3 14:32:21.765332 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Sep 3 14:32:21.765372 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Sep 3 14:32:21.765423 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Sep 3 14:32:21.765464 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 3 14:32:21.765536 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Sep 3 14:32:21.765589 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Sep 3 14:32:21.765636 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Sep 3 14:32:21.765707 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Sep 3 14:32:21.765756 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Sep 3 14:32:21.765823 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Sep 3 14:32:21.765871 kernel: pci 0000:00:02.0: reg 0x10: [io 0xc0c0-0xc0df] Sep 3 14:32:21.765920 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Sep 3 14:32:21.765967 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Sep 3 14:32:21.766027 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Sep 3 14:32:21.766074 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc07f] Sep 3 14:32:21.766121 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Sep 3 14:32:21.766165 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Sep 3 14:32:21.766224 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Sep 3 14:32:21.766297 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc0e0-0xc0ff] Sep 3 14:32:21.766345 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Sep 3 14:32:21.766390 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Sep 3 14:32:21.766436 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Sep 3 14:32:21.766484 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Sep 3 14:32:21.766530 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Sep 3 14:32:21.766576 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Sep 3 14:32:21.766624 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc100-0xc11f] Sep 3 14:32:21.766690 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfebd4000-0xfebd4fff] Sep 3 14:32:21.766749 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Sep 3 14:32:21.766797 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] Sep 3 14:32:21.766803 kernel: ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) Sep 3 14:32:21.766808 kernel: ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) Sep 3 14:32:21.766813 kernel: ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) Sep 3 14:32:21.766819 kernel: ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) Sep 3 14:32:21.766824 kernel: ACPI: PCI Interrupt Link [LNKE] (IRQs 5 *10 11) Sep 3 14:32:21.766829 kernel: ACPI: PCI Interrupt Link [LNKF] (IRQs 5 *10 11) Sep 3 14:32:21.766833 kernel: ACPI: PCI Interrupt Link [LNKG] (IRQs 5 10 *11) Sep 3 14:32:21.766838 kernel: ACPI: PCI Interrupt Link [LNKH] (IRQs 5 10 *11) Sep 3 14:32:21.766843 kernel: ACPI: PCI Interrupt Link [GSIA] (IRQs *16) Sep 3 14:32:21.766847 kernel: ACPI: PCI Interrupt Link [GSIB] (IRQs *17) Sep 3 14:32:21.766852 kernel: ACPI: PCI Interrupt Link [GSIC] (IRQs *18) Sep 3 14:32:21.766857 kernel: ACPI: PCI Interrupt Link [GSID] (IRQs *19) Sep 3 14:32:21.766861 kernel: ACPI: PCI Interrupt Link [GSIE] (IRQs *20) Sep 3 14:32:21.766867 kernel: ACPI: PCI Interrupt Link [GSIF] (IRQs *21) Sep 3 14:32:21.766872 kernel: ACPI: PCI Interrupt Link [GSIG] (IRQs *22) Sep 3 14:32:21.766876 kernel: ACPI: PCI Interrupt Link [GSIH] (IRQs *23) Sep 3 14:32:21.766881 kernel: iommu: Default domain type: Translated Sep 3 14:32:21.766926 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Sep 3 14:32:21.766970 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Sep 3 14:32:21.767014 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Sep 3 14:32:21.767020 kernel: vgaarb: loaded Sep 3 14:32:21.767024 kernel: PCI: Using ACPI for IRQ routing Sep 3 14:32:21.767031 kernel: PCI: pci_cache_line_size set to 64 bytes Sep 3 14:32:21.767035 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Sep 3 14:32:21.767040 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Sep 3 14:32:21.767044 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Sep 3 14:32:21.767049 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Sep 3 14:32:21.767054 kernel: clocksource: Switched to clocksource kvm-clock Sep 3 14:32:21.767058 kernel: VFS: Disk quotas dquot_6.6.0 Sep 3 14:32:21.767063 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 3 14:32:21.767068 kernel: pnp: PnP ACPI init Sep 3 14:32:21.767180 kernel: pnp 00:00: Plug and Play ACPI device, IDs PNP0303 (active) Sep 3 14:32:21.767261 kernel: pnp 00:01: Plug and Play ACPI device, IDs PNP0f13 (active) Sep 3 14:32:21.767325 kernel: pnp 00:02: Plug and Play ACPI device, IDs PNP0400 (active) Sep 3 14:32:21.767393 kernel: pnp 00:03: Plug and Play ACPI device, IDs PNP0501 (active) Sep 3 14:32:21.767450 kernel: pnp 00:04: Plug and Play ACPI device, IDs PNP0b00 (active) Sep 3 14:32:21.767515 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Sep 3 14:32:21.767560 kernel: system 00:05: Plug and Play ACPI device, IDs PNP0c01 (active) Sep 3 14:32:21.767566 kernel: pnp: PnP ACPI: found 6 devices Sep 3 14:32:21.767571 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 3 14:32:21.767576 kernel: NET: Registered protocol family 2 Sep 3 14:32:21.767581 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 3 14:32:21.767585 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 3 14:32:21.767590 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 3 14:32:21.767596 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Sep 3 14:32:21.767601 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 3 14:32:21.767606 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 3 14:32:21.767611 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 3 14:32:21.767616 kernel: NET: Registered protocol family 1 Sep 3 14:32:21.767620 kernel: NET: Registered protocol family 44 Sep 3 14:32:21.767682 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Sep 3 14:32:21.767723 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Sep 3 14:32:21.767763 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Sep 3 14:32:21.767806 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Sep 3 14:32:21.767858 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Sep 3 14:32:21.767899 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Sep 3 14:32:21.767944 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Sep 3 14:32:21.767951 kernel: PCI: CLS 0 bytes, default 64 Sep 3 14:32:21.767956 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Sep 3 14:32:21.767961 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Sep 3 14:32:21.767966 kernel: Initialise system trusted keyrings Sep 3 14:32:21.767970 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 3 14:32:21.767977 kernel: Key type asymmetric registered Sep 3 14:32:21.767981 kernel: Asymmetric key parser 'x509' registered Sep 3 14:32:21.767986 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Sep 3 14:32:21.767991 kernel: io scheduler mq-deadline registered Sep 3 14:32:21.767995 kernel: io scheduler kyber registered Sep 3 14:32:21.768000 kernel: io scheduler bfq registered Sep 3 14:32:21.768005 kernel: intel_idle: Please enable MWAIT in BIOS SETUP Sep 3 14:32:21.768009 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Sep 3 14:32:21.768014 kernel: PCI Interrupt Link [GSIG] enabled at IRQ 22 Sep 3 14:32:21.768020 kernel: PCI Interrupt Link [GSIH] enabled at IRQ 23 Sep 3 14:32:21.768025 kernel: PCI Interrupt Link [GSIE] enabled at IRQ 20 Sep 3 14:32:21.768030 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 3 14:32:21.768034 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Sep 3 14:32:21.768039 kernel: random: fast init done Sep 3 14:32:21.768043 kernel: random: crng init done Sep 3 14:32:21.768048 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Sep 3 14:32:21.768052 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Sep 3 14:32:21.768057 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Sep 3 14:32:21.768063 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Sep 3 14:32:21.768068 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Sep 3 14:32:21.768108 kernel: rtc_cmos 00:04: RTC can wake from S4 Sep 3 14:32:21.768115 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Sep 3 14:32:21.768154 kernel: rtc_cmos 00:04: registered as rtc0 Sep 3 14:32:21.768194 kernel: rtc_cmos 00:04: setting system clock to 2026-09-03T14:32:21 UTC (1788445941) Sep 3 14:32:21.768235 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Sep 3 14:32:21.768241 kernel: intel_pstate: CPU model not supported Sep 3 14:32:21.768246 kernel: NET: Registered protocol family 10 Sep 3 14:32:21.768265 kernel: Segment Routing with IPv6 Sep 3 14:32:21.768270 kernel: NET: Registered protocol family 17 Sep 3 14:32:21.768275 kernel: Key type dns_resolver registered Sep 3 14:32:21.768279 kernel: IPI shorthand broadcast: enabled Sep 3 14:32:21.768284 kernel: sched_clock: Marking stable (1128164927, 217326016)->(1458147997, -112657054) Sep 3 14:32:21.768289 kernel: registered taskstats version 1 Sep 3 14:32:21.768293 kernel: Loading compiled-in X.509 certificates Sep 3 14:32:21.768298 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: 5866c780451a04cc08b278527846e2b48fb1aa10' Sep 3 14:32:21.768312 kernel: Key type ._fscrypt registered Sep 3 14:32:21.768318 kernel: Key type .fscrypt registered Sep 3 14:32:21.768323 kernel: Key type fscrypt-provisioning registered Sep 3 14:32:21.768328 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 3 14:32:21.768334 kernel: ima: Allocated hash algorithm: sha1 Sep 3 14:32:21.768339 kernel: ima: No architecture policies found Sep 3 14:32:21.768344 kernel: Freeing unused kernel image (initmem) memory: 42228K Sep 3 14:32:21.768349 kernel: Write protecting the kernel read-only data: 24576k Sep 3 14:32:21.768354 kernel: Freeing unused kernel image (text/rodata gap) memory: 2040K Sep 3 14:32:21.768359 kernel: Freeing unused kernel image (rodata/data gap) memory: 648K Sep 3 14:32:21.768363 kernel: Run /init as init process Sep 3 14:32:21.768368 kernel: with arguments: Sep 3 14:32:21.768373 kernel: /init Sep 3 14:32:21.768377 kernel: with environment: Sep 3 14:32:21.768384 kernel: HOME=/ Sep 3 14:32:21.768388 kernel: TERM=linux Sep 3 14:32:21.768393 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 3 14:32:21.768399 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) Sep 3 14:32:21.768407 systemd[1]: Detected virtualization kvm. Sep 3 14:32:21.768412 systemd[1]: Detected architecture x86-64. Sep 3 14:32:21.768418 systemd[1]: Running in initial RAM disk. Sep 3 14:32:21.768422 systemd[1]: No hostname configured, using default hostname. Sep 3 14:32:21.768429 systemd[1]: Hostname set to . Sep 3 14:32:21.768435 systemd[1]: Initializing machine ID from VM UUID. Sep 3 14:32:21.768440 systemd[1]: Queued start job for default target Initrd Default Target. Sep 3 14:32:21.768445 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Sep 3 14:32:21.768450 systemd[1]: Reached target Local Encrypted Volumes. Sep 3 14:32:21.768455 systemd[1]: Reached target Path Units. Sep 3 14:32:21.768460 systemd[1]: Reached target Slice Units. Sep 3 14:32:21.768465 systemd[1]: Reached target Swaps. Sep 3 14:32:21.768470 systemd[1]: Reached target Timer Units. Sep 3 14:32:21.768477 systemd[1]: Listening on Open-iSCSI iscsid Socket. Sep 3 14:32:21.768482 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Sep 3 14:32:21.768487 systemd[1]: Listening on Journal Audit Socket. Sep 3 14:32:21.768492 systemd[1]: Listening on Journal Socket (/dev/log). Sep 3 14:32:21.768497 systemd[1]: Listening on Journal Socket. Sep 3 14:32:21.768502 systemd[1]: Listening on Network Service Netlink Socket. Sep 3 14:32:21.768508 systemd[1]: Listening on udev Control Socket. Sep 3 14:32:21.768514 systemd[1]: Listening on udev Kernel Socket. Sep 3 14:32:21.768519 systemd[1]: Reached target Socket Units. Sep 3 14:32:21.768524 systemd[1]: Starting Create List of Static Device Nodes... Sep 3 14:32:21.768530 systemd[1]: Finished Network Cleanup. Sep 3 14:32:21.768535 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Sep 3 14:32:21.768540 systemd[1]: Starting Journal Service... Sep 3 14:32:21.768545 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Sep 3 14:32:21.768550 systemd[1]: Starting Apply Kernel Variables... Sep 3 14:32:21.768555 systemd[1]: Starting Setup Virtual Console... Sep 3 14:32:21.768560 systemd[1]: Finished Create List of Static Device Nodes. Sep 3 14:32:21.768567 kernel: audit: type=1130 audit(1788445941.762: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' Sep 3 14:32:21.768572 systemd[1]: Finished Apply Kernel Variables. Sep 3 14:32:21.768580 systemd-journald[192]: Journal started Sep 3 14:32:21.768613 systemd-journald[192]: Runtime Journal (/run/log/journal/9eb0315650c94cff8f60cc6ade9e238b) is 6.0M, max 48.7M, 42.6M free. Sep 3 14:32:21.762000 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' Sep 3 14:32:21.770000 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' Sep 3 14:32:21.771678 kernel: audit: type=1130 audit(1788445941.770:3): 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' Sep 3 14:32:21.771693 systemd[1]: Started Journal Service. Sep 3 14:32:21.862000 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' Sep 3 14:32:21.864599 systemd[1]: Starting Create Static Device Nodes in /dev... Sep 3 14:32:21.872281 kernel: audit: type=1130 audit(1788445941.862:4): 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' Sep 3 14:32:21.870083 systemd[1]: Finished Setup Virtual Console. Sep 3 14:32:21.879757 kernel: audit: type=1130 audit(1788445941.872: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' Sep 3 14:32:21.872000 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' Sep 3 14:32:21.873627 systemd[1]: Finished Create Static Device Nodes in /dev. Sep 3 14:32:21.888214 kernel: audit: type=1130 audit(1788445941.881:6): 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' Sep 3 14:32:21.881000 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' Sep 3 14:32:21.888271 systemd[1]: Starting dracut ask for additional cmdline parameters... Sep 3 14:32:21.907248 systemd[1]: Finished dracut ask for additional cmdline parameters. Sep 3 14:32:21.915981 kernel: audit: type=1130 audit(1788445941.906:7): 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' Sep 3 14:32:21.906000 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' Sep 3 14:32:21.916141 systemd[1]: Starting dracut cmdline hook... Sep 3 14:32:21.930329 dracut-cmdline[211]: dracut-dracut-053 Sep 3 14:32:21.933232 dracut-cmdline[211]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=15990f5bb88d618f1948b7e8a720f1d5b95900cfecbef00df890bd0a136b39aa Sep 3 14:32:22.013733 kernel: SCSI subsystem initialized Sep 3 14:32:22.030728 kernel: Loading iSCSI transport class v2.0-870. Sep 3 14:32:22.040706 kernel: iscsi: registered transport (tcp) Sep 3 14:32:22.058212 kernel: iscsi: registered transport (qla4xxx) Sep 3 14:32:22.058351 kernel: QLogic iSCSI HBA Driver Sep 3 14:32:22.068989 systemd[1]: Finished dracut cmdline hook. Sep 3 14:32:22.076314 kernel: audit: type=1130 audit(1788445942.068: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' Sep 3 14:32:22.068000 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' Sep 3 14:32:22.076308 systemd[1]: Starting dracut pre-udev hook... Sep 3 14:32:22.099814 kernel: device-mapper: uevent: version 1.0.3 Sep 3 14:32:22.100075 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Sep 3 14:32:22.146058 kernel: raid6: avx512x4 gen() 44597 MB/s Sep 3 14:32:22.163740 kernel: raid6: avx512x4 xor() 10535 MB/s Sep 3 14:32:22.181684 kernel: raid6: avx512x2 gen() 43901 MB/s Sep 3 14:32:22.199793 kernel: raid6: avx512x2 xor() 28159 MB/s Sep 3 14:32:22.217768 kernel: raid6: avx512x1 gen() 42199 MB/s Sep 3 14:32:22.235825 kernel: raid6: avx512x1 xor() 25974 MB/s Sep 3 14:32:22.253716 kernel: raid6: avx2x4 gen() 37117 MB/s Sep 3 14:32:22.271693 kernel: raid6: avx2x4 xor() 9389 MB/s Sep 3 14:32:22.289689 kernel: raid6: avx2x2 gen() 37344 MB/s Sep 3 14:32:22.307822 kernel: raid6: avx2x2 xor() 23038 MB/s Sep 3 14:32:22.325681 kernel: raid6: avx2x1 gen() 28702 MB/s Sep 3 14:32:22.343684 kernel: raid6: avx2x1 xor() 18053 MB/s Sep 3 14:32:22.361844 kernel: raid6: sse2x4 gen() 11288 MB/s Sep 3 14:32:22.379841 kernel: raid6: sse2x4 xor() 5759 MB/s Sep 3 14:32:22.397794 kernel: raid6: sse2x2 gen() 10826 MB/s Sep 3 14:32:22.415786 kernel: raid6: sse2x2 xor() 7261 MB/s Sep 3 14:32:22.433786 kernel: raid6: sse2x1 gen() 8613 MB/s Sep 3 14:32:22.452401 kernel: raid6: sse2x1 xor() 6073 MB/s Sep 3 14:32:22.452442 kernel: raid6: using algorithm avx512x4 gen() 44597 MB/s Sep 3 14:32:22.452477 kernel: raid6: .... xor() 10535 MB/s, rmw enabled Sep 3 14:32:22.453775 kernel: raid6: using avx512x2 recovery algorithm Sep 3 14:32:22.470709 kernel: xor: automatically using best checksumming function avx Sep 3 14:32:22.552688 kernel: Btrfs loaded, crc32c=crc32c-intel Sep 3 14:32:22.564614 systemd[1]: Finished dracut pre-udev hook. Sep 3 14:32:22.572433 kernel: audit: type=1130 audit(1788445942.565: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' Sep 3 14:32:22.572457 kernel: audit: type=1334 audit(1788445942.572:10): prog-id=6 op=LOAD Sep 3 14:32:22.565000 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' Sep 3 14:32:22.572000 audit: BPF prog-id=6 op=LOAD Sep 3 14:32:22.573000 audit: BPF prog-id=7 op=LOAD Sep 3 14:32:22.573000 audit: BPF prog-id=8 op=LOAD Sep 3 14:32:22.574947 systemd[1]: Starting Rule-based Manager for Device Events and Files... Sep 3 14:32:22.592816 systemd-udevd[332]: /usr/lib64/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Sep 3 14:32:22.594581 systemd[1]: Started Rule-based Manager for Device Events and Files. Sep 3 14:32:22.596000 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' Sep 3 14:32:22.597425 systemd[1]: Starting dracut pre-trigger hook... Sep 3 14:32:22.600000 audit: BPF prog-id=9 op=LOAD Sep 3 14:32:22.600867 systemd[1]: Starting Network Configuration... Sep 3 14:32:22.607562 dracut-pre-trigger[338]: rd.md=0: removing MD RAID activation Sep 3 14:32:22.618169 systemd-networkd[339]: lo: Link UP Sep 3 14:32:22.618183 systemd-networkd[339]: lo: Gained carrier Sep 3 14:32:22.620000 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' Sep 3 14:32:22.620000 audit: BPF prog-id=10 op=LOAD Sep 3 14:32:22.618462 systemd-networkd[339]: Enumeration completed Sep 3 14:32:22.618548 systemd[1]: Started Network Configuration. Sep 3 14:32:22.622170 systemd[1]: Starting Network Name Resolution... Sep 3 14:32:22.634524 systemd[1]: Finished dracut pre-trigger hook. Sep 3 14:32:22.633000 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' Sep 3 14:32:22.635380 systemd[1]: Starting Coldplug All udev Devices... Sep 3 14:32:22.643541 systemd-udevd[332]: /usr/lib64/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Sep 3 14:32:22.657442 systemd-resolved[361]: Positive Trust Anchors: Sep 3 14:32:22.657638 systemd-resolved[361]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 3 14:32:22.657707 systemd-resolved[361]: 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 Sep 3 14:32:22.660000 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' Sep 3 14:32:22.658187 systemd-resolved[361]: Defaulting to hostname 'linux'. Sep 3 14:32:22.659387 systemd[1]: Started Network Name Resolution. Sep 3 14:32:22.660938 systemd[1]: Reached target Network. Sep 3 14:32:22.670570 systemd[1]: Reached target Host and Network Name Lookups. Sep 3 14:32:22.677000 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' Sep 3 14:32:22.673687 systemd[1]: Starting iSCSI UserSpace I/O driver... Sep 3 14:32:22.675393 systemd[1]: Finished Coldplug All udev Devices. Sep 3 14:32:22.680000 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' Sep 3 14:32:22.679929 systemd[1]: Started iSCSI UserSpace I/O driver. Sep 3 14:32:22.684942 iscsid[394]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Sep 3 14:32:22.684942 iscsid[394]: 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 Sep 3 14:32:22.684942 iscsid[394]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Sep 3 14:32:22.684942 iscsid[394]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Sep 3 14:32:22.684942 iscsid[394]: If using hardware iscsi like qla4xxx this message can be ignored. Sep 3 14:32:22.684942 iscsid[394]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Sep 3 14:32:22.684942 iscsid[394]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Sep 3 14:32:22.686000 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' Sep 3 14:32:22.681591 systemd[1]: Starting Open-iSCSI... Sep 3 14:32:22.685978 systemd[1]: Started Open-iSCSI. Sep 3 14:32:22.687782 systemd[1]: Starting dracut initqueue hook... Sep 3 14:32:22.723118 kernel: cryptd: max_cpu_qlen set to 1000 Sep 3 14:32:22.736789 systemd-udevd[375]: Using default interface naming scheme 'v249'. Sep 3 14:32:22.743856 kernel: AVX2 version of gcm_enc/dec engaged. Sep 3 14:32:22.743890 kernel: AES CTR mode by8 optimization enabled Sep 3 14:32:22.746678 kernel: libata version 3.00 loaded. Sep 3 14:32:22.783204 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 3 14:32:22.783494 kernel: vda: detected capacity change from 0 to 4756340736 Sep 3 14:32:22.785068 systemd-networkd[339]: eth0: Link UP Sep 3 14:32:22.788822 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 3 14:32:22.789674 kernel: ahci 0000:00:1f.2: version 3.0 Sep 3 14:32:22.790676 kernel: PCI Interrupt Link [GSIA] enabled at IRQ 16 Sep 3 14:32:22.791682 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Sep 3 14:32:22.791777 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Sep 3 14:32:22.794667 kernel: scsi host0: ahci Sep 3 14:32:22.795711 kernel: scsi host1: ahci Sep 3 14:32:22.795791 kernel: scsi host2: ahci Sep 3 14:32:22.796679 kernel: scsi host3: ahci Sep 3 14:32:22.796764 kernel: scsi host4: ahci Sep 3 14:32:22.796822 kernel: scsi host5: ahci Sep 3 14:32:22.796891 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 Sep 3 14:32:22.796898 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 Sep 3 14:32:22.796904 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 Sep 3 14:32:22.796910 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 Sep 3 14:32:22.796915 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 Sep 3 14:32:22.796922 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 Sep 3 14:32:23.113070 kernel: ata1: SATA link down (SStatus 0 SControl 300) Sep 3 14:32:23.113492 kernel: ata6: SATA link down (SStatus 0 SControl 300) Sep 3 14:32:23.113502 kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 3 14:32:23.113508 kernel: ata5: SATA link down (SStatus 0 SControl 300) Sep 3 14:32:23.115684 kernel: ata2: SATA link down (SStatus 0 SControl 300) Sep 3 14:32:23.117711 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 3 14:32:23.120448 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Sep 3 14:32:23.121602 kernel: ata3.00: applying bridge limits Sep 3 14:32:23.123013 kernel: ata3.00: configured for UDMA/100 Sep 3 14:32:23.127057 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Sep 3 14:32:23.154677 systemd[1]: Found device /dev/disk/by-label/ROOT. Sep 3 14:32:23.163098 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (380) Sep 3 14:32:23.158380 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Sep 3 14:32:23.163192 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 3 14:32:23.171950 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Sep 3 14:32:23.172335 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 3 14:32:23.177036 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Sep 3 14:32:23.181569 systemd[1]: Found device /dev/disk/by-label/OEM. Sep 3 14:32:23.181757 systemd[1]: Reached target Initrd Root Device. Sep 3 14:32:23.183138 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Sep 3 14:32:23.192720 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 3 14:32:23.197703 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 3 14:32:23.200211 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Sep 3 14:32:23.605334 systemd[1]: Finished dracut initqueue hook. Sep 3 14:32:23.607000 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' Sep 3 14:32:23.608534 systemd[1]: Reached target Preparation for Remote File Systems. Sep 3 14:32:23.611881 systemd[1]: Reached target Remote Encrypted Volumes. Sep 3 14:32:23.613395 systemd[1]: Reached target Remote File Systems. Sep 3 14:32:23.617778 systemd[1]: Starting dracut pre-mount hook... Sep 3 14:32:23.624890 systemd[1]: Finished dracut pre-mount hook. Sep 3 14:32:23.627000 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' Sep 3 14:32:23.783876 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Sep 3 14:32:23.784355 systemd-networkd[339]: eth0: Gained carrier Sep 3 14:32:23.793990 systemd-networkd[339]: eth0: DHCPv4 address 10.0.0.2/16 via 10.0.0.1 Sep 3 14:32:24.203758 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 3 14:32:24.204391 disk-uuid[466]: The operation has completed successfully. Sep 3 14:32:24.228448 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 3 14:32:24.228582 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Sep 3 14:32:24.231000 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' Sep 3 14:32:24.231000 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' Sep 3 14:32:24.232302 systemd[1]: Starting Ignition (setup)... Sep 3 14:32:24.246378 kernel: BTRFS info (device vda6): disk space caching is enabled Sep 3 14:32:24.246408 kernel: BTRFS info (device vda6): has skinny extents Sep 3 14:32:24.255484 systemd[1]: mnt-oem.mount: Deactivated successfully. Sep 3 14:32:24.260806 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 3 14:32:24.260924 systemd[1]: Finished Ignition (setup). Sep 3 14:32:24.262000 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' Sep 3 14:32:24.262000 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' Sep 3 14:32:24.263913 systemd[1]: Starting Ignition (disks)... Sep 3 14:32:24.281083 ignition[508]: Ignition v0.36.1-15-gde4e6cc9 Sep 3 14:32:24.281146 ignition[508]: Stage: disks Sep 3 14:32:24.281154 ignition[508]: reading system config file "/usr/lib/ignition/base.ign" Sep 3 14:32:24.281207 ignition[508]: no config at "/usr/lib/ignition/base.ign" Sep 3 14:32:24.281401 ignition[508]: parsed url from cmdline: "" Sep 3 14:32:24.281403 ignition[508]: no config URL provided Sep 3 14:32:24.281407 ignition[508]: reading system config file "/usr/lib/ignition/user.ign" Sep 3 14:32:24.281525 ignition[508]: no config at "/usr/lib/ignition/user.ign" Sep 3 14:32:24.281549 ignition[508]: op(1): [started] loading QEMU firmware config module Sep 3 14:32:24.281553 ignition[508]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 3 14:32:24.292041 ignition[508]: op(1): [finished] loading QEMU firmware config module Sep 3 14:32:24.320104 ignition[508]: parsing config with SHA512: 736626080b89aa2c9f6f977fec1697bcc0a0c96a124a5a8f4938ae0fbfd6d54522201668b95194186778d685b35a005ed97a3c0126ef08b14f0870c24f7f2259 Sep 3 14:32:24.322254 ignition[508]: disks: disks passed Sep 3 14:32:24.322454 ignition[508]: Ignition finished successfully Sep 3 14:32:24.323610 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 3 14:32:24.325000 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' Sep 3 14:32:24.325000 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' Sep 3 14:32:24.323926 systemd[1]: Finished Ignition (disks). Sep 3 14:32:24.325976 systemd[1]: Reached target Preparation for Local File Systems. Sep 3 14:32:24.329970 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Sep 3 14:32:24.334526 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Sep 3 14:32:24.343377 systemd-fsck[520]: ROOT: clean, 556/553792 files, 37783/553472 blocks Sep 3 14:32:24.350334 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Sep 3 14:32:24.353000 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' Sep 3 14:32:24.356000 systemd[1]: Mounting /sysroot... Sep 3 14:32:24.361687 kernel: device-mapper: verity: sha256 using implementation "sha256-generic" Sep 3 14:32:24.388009 systemd[1]: Found device /dev/mapper/usr. Sep 3 14:32:24.389229 systemd[1]: Starting File System Check on /dev/mapper/usr... Sep 3 14:32:24.391725 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Sep 3 14:32:24.393000 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' Sep 3 14:32:24.409755 systemd-fsck[535]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Sep 3 14:32:24.409755 systemd-fsck[535]: You must have r/w access to the filesystem or be root Sep 3 14:32:24.410756 systemd-fsck[532]: fsck failed with exit status 8. Sep 3 14:32:24.410772 systemd-fsck[532]: Ignoring error. Sep 3 14:32:24.413000 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' Sep 3 14:32:24.414353 systemd[1]: Finished File System Check on /dev/mapper/usr. Sep 3 14:32:24.415517 systemd[1]: Mounting /sysusr/usr... Sep 3 14:32:24.434022 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Sep 3 14:32:24.434310 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Sep 3 14:32:24.434340 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Sep 3 14:32:24.436721 systemd[1]: Mounted /sysroot. Sep 3 14:32:24.436892 systemd[1]: Mounted /sysusr/usr. Sep 3 14:32:24.438742 systemd[1]: Reached target Initrd Root File System. Sep 3 14:32:24.440249 systemd[1]: Reached target Local File Systems. Sep 3 14:32:24.442527 systemd[1]: Reached target System Initialization. Sep 3 14:32:24.444683 systemd[1]: Reached target Basic System. Sep 3 14:32:24.464231 systemd[1]: Mounting /sysroot/usr... Sep 3 14:32:24.468603 systemd[1]: Mounted /sysroot/usr. Sep 3 14:32:24.479423 systemd[1]: Starting Root filesystem setup... Sep 3 14:32:24.547287 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 3 14:32:24.547501 systemd[1]: Finished Root filesystem setup. Sep 3 14:32:24.549000 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' Sep 3 14:32:24.549000 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' Sep 3 14:32:24.551150 systemd[1]: Starting Ignition (files)... Sep 3 14:32:24.554927 systemd[1]: Starting /sysroot/boot... Sep 3 14:32:24.562523 ignition[550]: Ignition v0.36.1-15-gde4e6cc9 Sep 3 14:32:24.562548 ignition[550]: Stage: files Sep 3 14:32:24.562557 ignition[550]: reading system config file "/usr/lib/ignition/base.ign" Sep 3 14:32:24.562583 ignition[550]: no config at "/usr/lib/ignition/base.ign" Sep 3 14:32:24.563056 ignition[550]: files: compiled without relabeling support, skipping Sep 3 14:32:24.579345 systemd[1]: Finished /sysroot/boot. Sep 3 14:32:24.580000 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' Sep 3 14:32:24.631090 ignition[550]: files: createUsers: op(1): [started] creating or modifying user "core" Sep 3 14:32:24.631114 ignition[550]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Sep 3 14:32:24.635683 ignition[550]: files: createUsers: op(1): [finished] creating or modifying user "core" Sep 3 14:32:24.635745 ignition[550]: files: createUsers: op(2): [started] adding ssh keys to user "core" Sep 3 14:32:24.640592 ignition[550]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Sep 3 14:32:24.640620 ignition[550]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Sep 3 14:32:24.644740 ignition[550]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Sep 3 14:32:24.644758 ignition[550]: files: op(4): [started] processing unit "coreos-metadata.service" Sep 3 14:32:24.644787 ignition[550]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Sep 3 14:32:24.651406 ignition[550]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Sep 3 14:32:24.651423 ignition[550]: files: op(4): [finished] processing unit "coreos-metadata.service" Sep 3 14:32:24.651427 ignition[550]: files: files passed Sep 3 14:32:24.651431 ignition[550]: Ignition finished successfully Sep 3 14:32:24.658375 systemd[1]: ignition-files.service: Deactivated successfully. Sep 3 14:32:24.658506 systemd[1]: Finished Ignition (files). Sep 3 14:32:24.659000 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' Sep 3 14:32:24.659000 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' Sep 3 14:32:24.660115 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Sep 3 14:32:24.661939 systemd[1]: Starting Ignition (record completion)... Sep 3 14:32:24.665474 systemd[1]: Starting Reload Configuration from the Real Root... Sep 3 14:32:24.671233 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 3 14:32:24.671369 systemd[1]: Finished Ignition (record completion). Sep 3 14:32:24.673000 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' Sep 3 14:32:24.673000 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' Sep 3 14:32:24.674123 systemd[1]: Reloading. Sep 3 14:32:24.684000 audit: BPF prog-id=6 op=UNLOAD Sep 3 14:32:24.684000 audit: BPF prog-id=9 op=UNLOAD Sep 3 14:32:24.685000 audit: BPF prog-id=10 op=UNLOAD Sep 3 14:32:24.686000 audit: BPF prog-id=3 op=UNLOAD Sep 3 14:32:24.775000 audit: BPF prog-id=11 op=LOAD Sep 3 14:32:24.776000 audit: BPF prog-id=12 op=LOAD Sep 3 14:32:24.776000 audit: BPF prog-id=13 op=LOAD Sep 3 14:32:24.776000 audit: BPF prog-id=7 op=UNLOAD Sep 3 14:32:24.776000 audit: BPF prog-id=8 op=UNLOAD Sep 3 14:32:24.776000 audit: BPF prog-id=14 op=LOAD Sep 3 14:32:24.777000 audit: BPF prog-id=15 op=LOAD Sep 3 14:32:24.777000 audit: BPF prog-id=16 op=LOAD Sep 3 14:32:24.777000 audit: BPF prog-id=17 op=LOAD Sep 3 14:32:24.777000 audit: BPF prog-id=18 op=LOAD Sep 3 14:32:24.777000 audit: BPF prog-id=4 op=UNLOAD Sep 3 14:32:24.777000 audit: BPF prog-id=5 op=UNLOAD Sep 3 14:32:24.800160 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 3 14:32:24.801764 systemd[1]: Finished Reload Configuration from the Real Root. Sep 3 14:32:24.804000 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' Sep 3 14:32:24.804000 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' Sep 3 14:32:24.804833 systemd[1]: Reached target Initrd File Systems. Sep 3 14:32:24.807304 systemd[1]: Reached target Initrd Default Target. Sep 3 14:32:24.809943 systemd[1]: Condition check resulted in dracut mount hook being skipped. Sep 3 14:32:24.812379 systemd[1]: Starting dracut pre-pivot and cleanup hook... Sep 3 14:32:24.824932 systemd[1]: Finished dracut pre-pivot and cleanup hook. Sep 3 14:32:24.827000 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' Sep 3 14:32:24.828828 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Sep 3 14:32:24.835981 systemd[1]: Stopped target Host and Network Name Lookups. Sep 3 14:32:24.838862 systemd[1]: Stopped target Remote Encrypted Volumes. Sep 3 14:32:24.841590 systemd[1]: Stopped target Timer Units. Sep 3 14:32:24.843876 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 3 14:32:24.845301 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Sep 3 14:32:24.847000 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' Sep 3 14:32:24.848138 systemd[1]: Stopped target Initrd Default Target. Sep 3 14:32:24.850742 systemd[1]: Stopped target Basic System. Sep 3 14:32:24.853044 systemd[1]: Stopped target Initrd Root Device. Sep 3 14:32:24.855511 systemd[1]: Stopped target Path Units. Sep 3 14:32:24.858864 systemd[1]: Stopped target Remote File Systems. Sep 3 14:32:24.862332 systemd[1]: Stopped target Preparation for Remote File Systems. Sep 3 14:32:24.865453 systemd[1]: Stopped target Slice Units. Sep 3 14:32:24.867747 systemd[1]: Stopped target Socket Units. Sep 3 14:32:24.870179 systemd[1]: Stopped target System Initialization. Sep 3 14:32:24.872866 systemd[1]: Stopped target Local File Systems. Sep 3 14:32:24.875324 systemd[1]: Stopped target Preparation for Local File Systems. Sep 3 14:32:24.878344 systemd[1]: Stopped target Swaps. Sep 3 14:32:24.880465 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 3 14:32:24.882071 systemd[1]: Stopped dracut pre-mount hook. Sep 3 14:32:24.884000 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' Sep 3 14:32:24.884568 systemd[1]: Stopped target Local Encrypted Volumes. Sep 3 14:32:24.887184 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 3 14:32:24.892703 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Sep 3 14:32:24.895961 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 3 14:32:24.897411 systemd[1]: Stopped dracut initqueue hook. Sep 3 14:32:24.899000 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' Sep 3 14:32:24.899950 systemd[1]: Stopping Open-iSCSI... Sep 3 14:32:24.900798 iscsid[394]: iscsid shutting down. Sep 3 14:32:24.903774 systemd[1]: Stopping /sysroot/boot... Sep 3 14:32:24.905769 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 3 14:32:24.907342 systemd[1]: Stopped Coldplug All udev Devices. Sep 3 14:32:24.909000 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' Sep 3 14:32:24.909888 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 3 14:32:24.909965 systemd[1]: Stopped dracut pre-trigger hook. Sep 3 14:32:24.914000 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' Sep 3 14:32:24.916539 systemd[1]: iscsid.service: Deactivated successfully. Sep 3 14:32:24.918850 systemd[1]: Stopped Open-iSCSI. Sep 3 14:32:24.920000 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' Sep 3 14:32:24.921565 systemd[1]: iscsid.socket: Deactivated successfully. Sep 3 14:32:24.923020 systemd[1]: Closed Open-iSCSI iscsid Socket. Sep 3 14:32:24.925434 systemd[1]: Stopping iSCSI UserSpace I/O driver... Sep 3 14:32:24.928046 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 3 14:32:24.929480 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Sep 3 14:32:24.932000 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' Sep 3 14:32:24.932000 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' Sep 3 14:32:24.932454 systemd[1]: iscsiuio.service: Deactivated successfully. Sep 3 14:32:24.933792 systemd[1]: Stopped iSCSI UserSpace I/O driver. Sep 3 14:32:24.936000 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' Sep 3 14:32:24.937754 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 3 14:32:24.939371 systemd[1]: Stopped /sysroot/boot. Sep 3 14:32:24.941000 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' Sep 3 14:32:24.942423 systemd[1]: Stopped target Network. Sep 3 14:32:24.944559 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 3 14:32:24.945818 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Sep 3 14:32:24.948364 systemd[1]: Stopping Network Name Resolution... Sep 3 14:32:24.955224 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 3 14:32:24.956744 systemd[1]: Stopped Network Name Resolution. Sep 3 14:32:24.957000 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' Sep 3 14:32:24.959465 systemd[1]: Stopping Network Configuration... Sep 3 14:32:24.961000 audit: BPF prog-id=15 op=UNLOAD Sep 3 14:32:24.962813 systemd-networkd[339]: eth0: DHCP lease lost Sep 3 14:32:24.967755 systemd-networkd[339]: eth0: DHCPv6 lease lost Sep 3 14:32:24.969219 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 3 14:32:24.970714 systemd[1]: Stopped Network Configuration. Sep 3 14:32:24.972000 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' Sep 3 14:32:24.973212 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 3 14:32:24.974000 audit: BPF prog-id=14 op=UNLOAD Sep 3 14:32:24.973247 systemd[1]: Closed Network Service Netlink Socket. Sep 3 14:32:24.979427 systemd[1]: Stopping Network Cleanup... Sep 3 14:32:24.981700 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 3 14:32:24.981769 systemd[1]: Stopped Apply Kernel Variables. Sep 3 14:32:24.985000 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' Sep 3 14:32:24.986849 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Sep 3 14:32:24.992842 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 3 14:32:24.995000 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' Sep 3 14:32:24.994562 systemd[1]: Stopped Network Cleanup. Sep 3 14:32:24.997122 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 3 14:32:24.999618 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Sep 3 14:32:25.002000 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' Sep 3 14:32:25.003832 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 3 14:32:25.003953 systemd[1]: Closed udev Control Socket. Sep 3 14:32:25.006000 audit: BPF prog-id=11 op=UNLOAD Sep 3 14:32:25.007637 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 3 14:32:25.007706 systemd[1]: Closed udev Kernel Socket. Sep 3 14:32:25.011408 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 3 14:32:25.011455 systemd[1]: Stopped dracut pre-udev hook. Sep 3 14:32:25.014000 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' Sep 3 14:32:25.015075 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 3 14:32:25.017000 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' Sep 3 14:32:25.015105 systemd[1]: Stopped dracut cmdline hook. Sep 3 14:32:25.018338 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 3 14:32:25.020873 systemd[1]: Stopped dracut ask for additional cmdline parameters. Sep 3 14:32:25.023000 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' Sep 3 14:32:25.025417 systemd[1]: Starting Cleanup udev Database... Sep 3 14:32:25.028428 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Sep 3 14:32:25.031158 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 3 14:32:25.031205 systemd[1]: Stopped Create Static Device Nodes in /dev. Sep 3 14:32:25.035000 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' Sep 3 14:32:25.035524 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 3 14:32:25.035556 systemd[1]: Stopped Create List of Static Device Nodes. Sep 3 14:32:25.038000 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' Sep 3 14:32:25.039676 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 3 14:32:25.039717 systemd[1]: Stopped Setup Virtual Console. Sep 3 14:32:25.043000 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' Sep 3 14:32:25.044741 systemd[1]: rngd.service: Deactivated successfully. Sep 3 14:32:25.046754 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Sep 3 14:32:25.049000 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' Sep 3 14:32:25.051050 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 3 14:32:25.052794 systemd[1]: Finished Cleanup udev Database. Sep 3 14:32:25.055000 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' Sep 3 14:32:25.055000 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' Sep 3 14:32:25.056753 systemd[1]: Reached target Switch Root. Sep 3 14:32:25.060218 systemd[1]: Starting Switch Root... Sep 3 14:32:25.068976 systemd[1]: Switching root. Sep 3 14:32:25.071000 audit: BPF prog-id=16 op=UNLOAD Sep 3 14:32:25.089562 systemd-journald[192]: Journal stopped Sep 3 14:32:28.660586 systemd-journald[192]: Received SIGTERM from PID 1 (n/a). Sep 3 14:32:28.660671 kernel: SELinux: policy capability network_peer_controls=1 Sep 3 14:32:28.660682 kernel: SELinux: policy capability open_perms=1 Sep 3 14:32:28.660689 kernel: SELinux: policy capability extended_socket_class=1 Sep 3 14:32:28.660699 kernel: SELinux: policy capability always_check_network=0 Sep 3 14:32:28.660707 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 3 14:32:28.660714 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 3 14:32:28.660724 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 3 14:32:28.660732 systemd[1]: Successfully loaded SELinux policy in 58.591ms. Sep 3 14:32:28.660746 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 8.110ms. Sep 3 14:32:28.660757 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) Sep 3 14:32:28.660764 systemd[1]: Detected virtualization kvm. Sep 3 14:32:28.660772 systemd[1]: Detected architecture x86-64. Sep 3 14:32:28.660780 systemd[1]: Detected first boot. Sep 3 14:32:28.660787 systemd[1]: Initializing machine ID from VM UUID. Sep 3 14:32:28.660799 kernel: hrtimer: interrupt took 4340041 ns Sep 3 14:32:28.660807 systemd[1]: Populated /etc with preset unit settings. Sep 3 14:32:28.660815 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. Sep 3 14:32:28.660824 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Sep 3 14:32:28.660832 kernel: kauditd_printk_skb: 84 callbacks suppressed Sep 3 14:32:28.660840 kernel: audit: type=1334 audit(1788445948.415:95): prog-id=21 op=LOAD Sep 3 14:32:28.660847 kernel: audit: type=1334 audit(1788445948.418:96): prog-id=22 op=LOAD Sep 3 14:32:28.660855 kernel: audit: type=1334 audit(1788445948.420:97): prog-id=23 op=LOAD Sep 3 14:32:28.660862 kernel: audit: type=1334 audit(1788445948.420:98): prog-id=17 op=UNLOAD Sep 3 14:32:28.660870 kernel: audit: type=1334 audit(1788445948.420:99): prog-id=18 op=UNLOAD Sep 3 14:32:28.660877 kernel: audit: type=1334 audit(1788445948.435:100): prog-id=24 op=LOAD Sep 3 14:32:28.660884 kernel: audit: type=1334 audit(1788445948.435:101): prog-id=21 op=UNLOAD Sep 3 14:32:28.660891 kernel: audit: type=1334 audit(1788445948.438:102): prog-id=25 op=LOAD Sep 3 14:32:28.660899 kernel: audit: type=1334 audit(1788445948.440:103): prog-id=26 op=LOAD Sep 3 14:32:28.660908 kernel: audit: type=1334 audit(1788445948.440:104): prog-id=22 op=UNLOAD Sep 3 14:32:28.660916 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 3 14:32:28.660924 systemd[1]: Stopped Switch Root. Sep 3 14:32:28.660932 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 3 14:32:28.660940 systemd[1]: Created slice Slice /system/addon-config. Sep 3 14:32:28.660947 systemd[1]: Created slice Slice /system/addon-run. Sep 3 14:32:28.660955 systemd[1]: Created slice Slice /system/getty. Sep 3 14:32:28.660962 systemd[1]: Created slice Slice /system/modprobe. Sep 3 14:32:28.660970 systemd[1]: Created slice Slice /system/serial-getty. Sep 3 14:32:28.660977 systemd[1]: Created slice Slice /system/system-cloudinit. Sep 3 14:32:28.660985 systemd[1]: Created slice Slice /system/systemd-fsck. Sep 3 14:32:28.660992 systemd[1]: Created slice User and Session Slice. Sep 3 14:32:28.661000 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Sep 3 14:32:28.661008 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Sep 3 14:32:28.661015 systemd[1]: Set up automount Boot partition Automount Point. Sep 3 14:32:28.661022 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Sep 3 14:32:28.661030 systemd[1]: Stopped target Switch Root. Sep 3 14:32:28.661038 systemd[1]: Stopped target Initrd File Systems. Sep 3 14:32:28.661045 systemd[1]: Stopped target Initrd Root File System. Sep 3 14:32:28.661052 systemd[1]: Reached target Remote Encrypted Volumes. Sep 3 14:32:28.661060 systemd[1]: Reached target Remote File Systems. Sep 3 14:32:28.661069 systemd[1]: Reached target Slice Units. Sep 3 14:32:28.661076 systemd[1]: Reached target Swaps. Sep 3 14:32:28.661083 systemd[1]: Reached target Verify torcx succeeded. Sep 3 14:32:28.661090 systemd[1]: Reached target Local Verity Protected Volumes. Sep 3 14:32:28.661097 systemd[1]: Listening on Process Core Dump Socket. Sep 3 14:32:28.661104 systemd[1]: Listening on initctl Compatibility Named Pipe. Sep 3 14:32:28.661111 systemd[1]: Listening on Network Service Netlink Socket. Sep 3 14:32:28.661122 systemd[1]: Listening on udev Control Socket. Sep 3 14:32:28.661133 systemd[1]: Listening on udev Kernel Socket. Sep 3 14:32:28.661145 systemd[1]: Mounting Huge Pages File System... Sep 3 14:32:28.661160 systemd[1]: Mounting POSIX Message Queue File System... Sep 3 14:32:28.661168 systemd[1]: Mounting External Media Directory... Sep 3 14:32:28.661176 systemd[1]: Condition check resulted in /proc/xen being skipped. Sep 3 14:32:28.661183 systemd[1]: Mounting Kernel Debug File System... Sep 3 14:32:28.661191 systemd[1]: Mounting Kernel Trace File System... Sep 3 14:32:28.661198 systemd[1]: Mounting Temporary Directory /tmp... Sep 3 14:32:28.661205 systemd[1]: Starting Create missing system files... Sep 3 14:32:28.661213 systemd[1]: Starting Create List of Static Device Nodes... Sep 3 14:32:28.661220 systemd[1]: Starting Load Kernel Module configfs... Sep 3 14:32:28.661227 systemd[1]: Starting Load Kernel Module drm... Sep 3 14:32:28.661236 systemd[1]: Starting Load Kernel Module fuse... Sep 3 14:32:28.661243 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Sep 3 14:32:28.661250 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 3 14:32:28.661258 systemd[1]: Stopped File System Check on Root Device. Sep 3 14:32:28.661265 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 3 14:32:28.661272 systemd[1]: Stopped systemd-fsck-usr.service. Sep 3 14:32:28.661279 kernel: fuse: init (API version 7.32) Sep 3 14:32:28.661317 systemd[1]: Stopped Journal Service. Sep 3 14:32:28.661325 systemd[1]: Starting Journal Service... Sep 3 14:32:28.661335 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Sep 3 14:32:28.661343 systemd[1]: Starting Remount Root and Kernel File Systems... Sep 3 14:32:28.661351 systemd[1]: Starting Apply Kernel Variables... Sep 3 14:32:28.661358 systemd[1]: Starting Coldplug All udev Devices... Sep 3 14:32:28.661368 systemd-journald[768]: Journal started Sep 3 14:32:28.661399 systemd-journald[768]: Runtime Journal (/run/log/journal/9eb0315650c94cff8f60cc6ade9e238b) is 6.0M, max 48.7M, 42.6M free. Sep 3 14:32:25.282000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 3 14:32:25.352000 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 Sep 3 14:32:25.352000 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 Sep 3 14:32:25.352000 audit: BPF prog-id=19 op=LOAD Sep 3 14:32:25.352000 audit: BPF prog-id=19 op=UNLOAD Sep 3 14:32:25.352000 audit: BPF prog-id=20 op=LOAD Sep 3 14:32:25.352000 audit: BPF prog-id=20 op=UNLOAD Sep 3 14:32:25.442000 audit[714]: AVC avc: denied { associate } for pid=714 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 Sep 3 14:32:28.415000 audit: BPF prog-id=21 op=LOAD Sep 3 14:32:28.418000 audit: BPF prog-id=22 op=LOAD Sep 3 14:32:28.420000 audit: BPF prog-id=23 op=LOAD Sep 3 14:32:28.420000 audit: BPF prog-id=17 op=UNLOAD Sep 3 14:32:28.420000 audit: BPF prog-id=18 op=UNLOAD Sep 3 14:32:28.435000 audit: BPF prog-id=24 op=LOAD Sep 3 14:32:28.435000 audit: BPF prog-id=21 op=UNLOAD Sep 3 14:32:28.438000 audit: BPF prog-id=25 op=LOAD Sep 3 14:32:28.440000 audit: BPF prog-id=26 op=LOAD Sep 3 14:32:28.440000 audit: BPF prog-id=22 op=UNLOAD Sep 3 14:32:28.440000 audit: BPF prog-id=23 op=UNLOAD Sep 3 14:32:28.444000 audit: BPF prog-id=27 op=LOAD Sep 3 14:32:28.444000 audit: BPF prog-id=24 op=UNLOAD Sep 3 14:32:28.444000 audit: BPF prog-id=28 op=LOAD Sep 3 14:32:28.444000 audit: BPF prog-id=29 op=LOAD Sep 3 14:32:28.444000 audit: BPF prog-id=25 op=UNLOAD Sep 3 14:32:28.444000 audit: BPF prog-id=26 op=UNLOAD Sep 3 14:32:28.445000 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' Sep 3 14:32:28.450000 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' Sep 3 14:32:28.450000 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' Sep 3 14:32:28.455000 audit: BPF prog-id=27 op=UNLOAD Sep 3 14:32:28.622000 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' Sep 3 14:32:28.627000 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' Sep 3 14:32:28.630000 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' Sep 3 14:32:28.630000 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' Sep 3 14:32:28.639000 audit: BPF prog-id=30 op=LOAD Sep 3 14:32:28.639000 audit: BPF prog-id=31 op=LOAD Sep 3 14:32:28.639000 audit: BPF prog-id=32 op=LOAD Sep 3 14:32:28.639000 audit: BPF prog-id=28 op=UNLOAD Sep 3 14:32:28.639000 audit: BPF prog-id=29 op=UNLOAD Sep 3 14:32:28.658000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Sep 3 14:32:25.437212 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" 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]" Sep 3 14:32:28.415469 systemd[1]: Queued start job for default target Multi-User System. Sep 3 14:32:25.438414 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Sep 3 14:32:28.445594 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 3 14:32:25.438431 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Sep 3 14:32:25.438559 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Sep 3 14:32:25.438568 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=debug msg="skipped missing lower profile" missing profile=oem Sep 3 14:32:25.438596 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Sep 3 14:32:25.438607 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Sep 3 14:32:25.438943 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Sep 3 14:32:25.438974 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Sep 3 14:32:25.438995 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Sep 3 14:32:25.440127 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" 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 Sep 3 14:32:25.440156 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" 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 Sep 3 14:32:25.440175 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" 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 Sep 3 14:32:25.440186 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Sep 3 14:32:25.440201 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" 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 Sep 3 14:32:25.440212 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:25Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Sep 3 14:32:28.165594 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:28Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Sep 3 14:32:28.166802 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:28Z" 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 Sep 3 14:32:28.166942 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:28Z" 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 Sep 3 14:32:28.167089 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:28Z" 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 Sep 3 14:32:28.167189 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:28Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Sep 3 14:32:28.167268 /usr/lib64/systemd/system-generators/torcx-generator[714]: time="2026-09-03T14:32:28Z" 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 Sep 3 14:32:28.665935 systemd[1]: verity-setup.service: Deactivated successfully. Sep 3 14:32:28.666588 systemd[1]: Stopped verity-setup.service. Sep 3 14:32:28.667000 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' Sep 3 14:32:28.672061 systemd[1]: Condition check resulted in Set fake PV driver version for XenServer being skipped. Sep 3 14:32:28.676447 systemd[1]: Started Journal Service. Sep 3 14:32:28.676000 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' Sep 3 14:32:28.677135 systemd[1]: Mounted Huge Pages File System. Sep 3 14:32:28.678599 systemd[1]: Mounted POSIX Message Queue File System. Sep 3 14:32:28.680186 systemd[1]: Mounted External Media Directory. Sep 3 14:32:28.681637 systemd[1]: Mounted Kernel Debug File System. Sep 3 14:32:28.683154 systemd[1]: Mounted Kernel Trace File System. Sep 3 14:32:28.684637 systemd[1]: Mounted Temporary Directory /tmp. Sep 3 14:32:28.686406 systemd[1]: Finished Create missing system files. Sep 3 14:32:28.687000 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' Sep 3 14:32:28.688195 systemd[1]: Finished Create List of Static Device Nodes. Sep 3 14:32:28.689000 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' Sep 3 14:32:28.690022 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 3 14:32:28.690325 systemd[1]: Finished Load Kernel Module configfs. Sep 3 14:32:28.692000 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' Sep 3 14:32:28.692000 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' Sep 3 14:32:28.702467 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 3 14:32:28.702978 systemd[1]: Finished Load Kernel Module drm. Sep 3 14:32:28.704000 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' Sep 3 14:32:28.704000 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' Sep 3 14:32:28.704538 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 3 14:32:28.705527 systemd[1]: Finished Load Kernel Module fuse. Sep 3 14:32:28.707000 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' Sep 3 14:32:28.707000 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' Sep 3 14:32:28.708702 systemd[1]: Finished Remount Root and Kernel File Systems. Sep 3 14:32:28.710000 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' Sep 3 14:32:28.710582 systemd[1]: Finished Apply Kernel Variables. Sep 3 14:32:28.711000 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' Sep 3 14:32:28.714896 systemd[1]: Mounting FUSE Control File System... Sep 3 14:32:28.716916 systemd[1]: Mounting Kernel Configuration File System... Sep 3 14:32:28.718164 systemd[1]: Condition check resulted in Remount Root File System being skipped. Sep 3 14:32:28.720633 systemd[1]: Starting Rebuild Hardware Database... Sep 3 14:32:28.724602 systemd[1]: Starting Flush Journal to Persistent Storage... Sep 3 14:32:28.725956 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Sep 3 14:32:28.729068 systemd[1]: Starting Load/Save Random Seed... Sep 3 14:32:28.734499 systemd-journald[768]: Time spent on flushing to /var/log/journal/9eb0315650c94cff8f60cc6ade9e238b is 12.349ms for 1000 entries. Sep 3 14:32:28.734499 systemd-journald[768]: System Journal (/var/log/journal/9eb0315650c94cff8f60cc6ade9e238b) is 8.0M, max 203.0M, 195.0M free. Sep 3 14:32:28.749000 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' Sep 3 14:32:28.751000 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' Sep 3 14:32:28.732673 systemd[1]: Starting Create System Users... Sep 3 14:32:28.735402 systemd[1]: Mounted FUSE Control File System. Sep 3 14:32:28.738157 systemd[1]: Mounted Kernel Configuration File System. Sep 3 14:32:28.748474 systemd[1]: Finished Coldplug All udev Devices. Sep 3 14:32:28.750156 systemd[1]: Finished Load/Save Random Seed. Sep 3 14:32:28.751459 systemd[1]: Reached target First Boot Complete. Sep 3 14:32:28.764000 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' Sep 3 14:32:28.759268 systemd[1]: Starting Wait for udev To Complete Device Initialization... Sep 3 14:32:28.762033 systemd-sysusers[780]: Creating group sgx with gid 999. Sep 3 14:32:28.762751 systemd[1]: Finished Flush Journal to Persistent Storage. Sep 3 14:32:28.765090 systemd-sysusers[780]: Creating group systemd-oom with gid 998. Sep 3 14:32:28.765749 systemd-sysusers[780]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Sep 3 14:32:28.766436 systemd-sysusers[780]: Creating group systemd-timesync with gid 997. Sep 3 14:32:28.767070 systemd-sysusers[780]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Sep 3 14:32:28.768500 systemd-sysusers[780]: Creating group systemd-coredump with gid 996. Sep 3 14:32:28.769007 systemd-sysusers[780]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Sep 3 14:32:28.789556 systemd[1]: Finished Create System Users. Sep 3 14:32:28.790000 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' Sep 3 14:32:28.800435 systemd[1]: Starting Create Static Device Nodes in /dev... Sep 3 14:32:28.845840 systemd[1]: Finished Create Static Device Nodes in /dev. Sep 3 14:32:28.846000 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' Sep 3 14:32:29.046217 systemd[1]: Finished Rebuild Hardware Database. Sep 3 14:32:29.047000 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' Sep 3 14:32:29.059000 audit: BPF prog-id=33 op=LOAD Sep 3 14:32:29.059000 audit: BPF prog-id=34 op=LOAD Sep 3 14:32:29.060000 audit: BPF prog-id=35 op=LOAD Sep 3 14:32:29.060000 audit: BPF prog-id=12 op=UNLOAD Sep 3 14:32:29.060000 audit: BPF prog-id=13 op=UNLOAD Sep 3 14:32:29.062204 systemd[1]: Starting Rule-based Manager for Device Events and Files... Sep 3 14:32:29.097943 systemd[1]: Started Rule-based Manager for Device Events and Files. Sep 3 14:32:29.099000 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' Sep 3 14:32:29.106000 audit: BPF prog-id=36 op=LOAD Sep 3 14:32:29.108078 systemd[1]: Starting Network Configuration... Sep 3 14:32:29.122698 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Sep 3 14:32:29.127895 kernel: ACPI: Power Button [PWRF] Sep 3 14:32:29.130845 systemd-udevd[786]: Using default interface naming scheme 'v249'. Sep 3 14:32:29.142000 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 Sep 3 14:32:29.155283 systemd-networkd[794]: lo: Link UP Sep 3 14:32:29.155319 systemd-networkd[794]: lo: Gained carrier Sep 3 14:32:29.156565 systemd-networkd[794]: Enumeration completed Sep 3 14:32:29.156724 systemd[1]: Started Network Configuration. Sep 3 14:32:29.158016 systemd-networkd[794]: eth0: Link UP Sep 3 14:32:29.157000 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' Sep 3 14:32:29.163803 systemd-networkd[794]: eth0: Gained carrier Sep 3 14:32:29.171884 systemd-networkd[794]: eth0: DHCPv4 address 10.0.0.2/16 via 10.0.0.1 Sep 3 14:32:29.191809 udevadm[783]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Sep 3 14:32:29.195673 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Sep 3 14:32:29.195843 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Sep 3 14:32:29.195925 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Sep 3 14:32:29.213680 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Sep 3 14:32:29.381069 kernel: mousedev: PS/2 mouse device common for all mice Sep 3 14:32:29.492888 systemd[1]: Finished Wait for udev To Complete Device Initialization. Sep 3 14:32:29.493000 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' Sep 3 14:32:29.514248 systemd[1]: Starting Activation of LVM2 logical volumes... Sep 3 14:32:29.538185 lvm[815]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 3 14:32:29.582264 systemd[1]: Finished Activation of LVM2 logical volumes. Sep 3 14:32:29.583000 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' Sep 3 14:32:29.584090 systemd[1]: Reached target Local Encrypted Volumes. Sep 3 14:32:29.599277 systemd[1]: Starting Activation of LVM2 logical volumes... Sep 3 14:32:29.604177 lvm[816]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 3 14:32:29.633564 systemd[1]: Finished Activation of LVM2 logical volumes. Sep 3 14:32:29.634000 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' Sep 3 14:32:29.635038 systemd[1]: Reached target Preparation for Local File Systems. Sep 3 14:32:29.636525 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Sep 3 14:32:29.636539 systemd[1]: Reached target Containers. Sep 3 14:32:29.647948 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Sep 3 14:32:29.672221 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Sep 3 14:32:29.673000 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' Sep 3 14:32:29.680334 systemd[1]: Mounting /usr/share/oem... Sep 3 14:32:29.693521 kernel: BTRFS info (device vda6): disk space caching is enabled Sep 3 14:32:29.693786 kernel: BTRFS info (device vda6): has skinny extents Sep 3 14:32:29.697519 systemd[1]: Mounted /usr/share/oem. Sep 3 14:32:29.698906 systemd[1]: Reached target Local File Systems. Sep 3 14:32:29.715218 systemd[1]: Starting Rebuild Dynamic Linker Cache... Sep 3 14:32:29.717323 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Sep 3 14:32:29.718619 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Sep 3 14:32:29.724386 systemd[1]: Starting Commit a transient machine-id on disk... Sep 3 14:32:29.729252 systemd[1]: Starting Create Volatile Files and Directories... Sep 3 14:32:29.760530 systemd-tmpfiles[841]: /usr/lib64/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Sep 3 14:32:29.761451 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 3 14:32:29.763362 systemd-tmpfiles[841]: /usr/lib64/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Sep 3 14:32:29.763811 systemd[1]: Finished Commit a transient machine-id on disk. Sep 3 14:32:29.765000 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' Sep 3 14:32:29.802584 systemd-tmpfiles[841]: Detected autofs mount point /boot during canonicalization of /boot. Sep 3 14:32:29.802605 systemd-tmpfiles[841]: Skipping /boot Sep 3 14:32:29.809024 systemd-tmpfiles[841]: Detected autofs mount point /boot during canonicalization of /boot. Sep 3 14:32:29.809051 systemd-tmpfiles[841]: Skipping /boot Sep 3 14:32:29.861371 systemd[1]: Finished Create Volatile Files and Directories. Sep 3 14:32:29.862000 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' Sep 3 14:32:29.869553 systemd[1]: Starting Load Security Auditing Rules... Sep 3 14:32:29.872173 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Sep 3 14:32:29.877000 audit: BPF prog-id=37 op=LOAD Sep 3 14:32:29.875706 systemd[1]: Starting Rebuild Journal Catalog... Sep 3 14:32:29.878787 systemd[1]: Starting Network Name Resolution... Sep 3 14:32:29.880000 audit: BPF prog-id=38 op=LOAD Sep 3 14:32:29.882339 systemd[1]: Starting Network Time Synchronization... Sep 3 14:32:29.884958 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Sep 3 14:32:29.890082 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Sep 3 14:32:29.891000 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' Sep 3 14:32:29.892038 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Sep 3 14:32:29.894000 audit[853]: SYSTEM_BOOT pid=853 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' Sep 3 14:32:29.900849 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Sep 3 14:32:29.902000 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' Sep 3 14:32:29.904856 systemd[1]: Finished Rebuild Journal Catalog. Sep 3 14:32:29.905000 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' Sep 3 14:32:29.930623 systemd[1]: Started Network Time Synchronization. Sep 3 14:32:29.931000 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' Sep 3 14:32:29.932433 systemd[1]: Reached target System Time Set. Sep 3 14:32:29.940462 systemd-timesyncd[852]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Sep 3 14:32:29.941424 systemd-resolved[851]: Positive Trust Anchors: Sep 3 14:32:29.941443 systemd-resolved[851]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 3 14:32:29.941467 systemd-resolved[851]: 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 Sep 3 14:32:29.942464 systemd-resolved[851]: Defaulting to hostname 'linux'. Sep 3 14:32:29.942000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Sep 3 14:32:29.943023 augenrules[863]: No rules Sep 3 14:32:29.944718 systemd[1]: Finished Load Security Auditing Rules. Sep 3 14:32:29.946383 systemd[1]: Started Network Name Resolution. Sep 3 14:32:29.947896 systemd[1]: Reached target Network. Sep 3 14:32:29.949954 systemd[1]: Reached target Host and Network Name Lookups. Sep 3 14:32:30.222893 systemd[1]: Finished Rebuild Dynamic Linker Cache. Sep 3 14:32:30.235277 systemd[1]: Starting Update is Completed... Sep 3 14:32:30.246143 systemd[1]: Finished Update is Completed. Sep 3 14:32:30.247555 systemd[1]: Reached target System Initialization. Sep 3 14:32:30.249048 systemd[1]: Started Watch for update engine configuration changes. Sep 3 14:32:30.252538 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 3 14:32:30.255165 systemd[1]: Started Daily Log Rotation. Sep 3 14:32:30.256612 systemd[1]: Started Weekly check for MD array's redundancy information.. Sep 3 14:32:30.258589 systemd[1]: Started Daily Cleanup of Temporary Directories. Sep 3 14:32:30.260202 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Sep 3 14:32:30.260240 systemd[1]: Reached target Path Units. Sep 3 14:32:30.261452 systemd[1]: Reached target Timer Units. Sep 3 14:32:30.263888 systemd[1]: Listening on D-Bus System Message Bus Socket. Sep 3 14:32:30.276725 systemd[1]: Starting Docker Socket for the API... Sep 3 14:32:30.280290 systemd[1]: Listening on OpenSSH Server Socket. Sep 3 14:32:30.282029 systemd[1]: Listening on Docker Socket for the API. Sep 3 14:32:30.283547 systemd[1]: Reached target Socket Units. Sep 3 14:32:30.284840 systemd[1]: Reached target Basic System. Sep 3 14:32:30.286115 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Sep 3 14:32:30.286139 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Sep 3 14:32:30.287102 systemd[1]: Started D-Bus System Message Bus. Sep 3 14:32:30.290782 systemd[1]: Starting Extend Filesystems... Sep 3 14:32:30.292050 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Sep 3 14:32:30.292958 systemd[1]: Starting Generate /run/flatcar/motd... Sep 3 14:32:30.295124 systemd[1]: Starting Install an ssh key from /proc/cmdline... Sep 3 14:32:30.297648 systemd[1]: Starting Generate sshd host keys... Sep 3 14:32:30.300832 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Sep 3 14:32:30.300874 systemd[1]: Reached target Load system-provided cloud configs. Sep 3 14:32:30.305708 extend-filesystems[873]: Found sr0 Sep 3 14:32:30.315312 extend-filesystems[873]: Found vda Sep 3 14:32:30.315312 extend-filesystems[873]: Found vda1 Sep 3 14:32:30.315312 extend-filesystems[873]: Found vda2 Sep 3 14:32:30.315312 extend-filesystems[873]: Found vda3 Sep 3 14:32:30.315312 extend-filesystems[873]: Found usr Sep 3 14:32:30.315312 extend-filesystems[873]: Found vda4 Sep 3 14:32:30.315312 extend-filesystems[873]: Found vda6 Sep 3 14:32:30.315312 extend-filesystems[873]: Found vda7 Sep 3 14:32:30.315312 extend-filesystems[873]: Found vda9 Sep 3 14:32:30.315312 extend-filesystems[873]: Checking size of /dev/vda9 Sep 3 14:32:30.309162 systemd[1]: Starting User Login Management... Sep 3 14:32:30.341485 extend-filesystems[873]: Old size kept for /dev/vda9 Sep 3 14:32:30.309171 systemd-networkd[794]: eth0: Gained IPv6LL Sep 3 14:32:30.317149 systemd[1]: Condition check resulted in TCG Core Services Daemon being skipped. Sep 3 14:32:30.327074 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 3 14:32:30.328148 systemd[1]: Starting Update Engine... Sep 3 14:32:30.329324 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Sep 3 14:32:30.329343 systemd[1]: Reached target Load user-provided cloud configs. Sep 3 14:32:30.331808 systemd[1]: motdgen.service: Deactivated successfully. Sep 3 14:32:30.332028 systemd[1]: Finished Generate /run/flatcar/motd. Sep 3 14:32:30.333858 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 3 14:32:30.334060 systemd[1]: Finished Install an ssh key from /proc/cmdline. Sep 3 14:32:30.339518 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 3 14:32:30.339777 systemd[1]: Finished Extend Filesystems. Sep 3 14:32:30.347488 systemd-logind[885]: Watching system buttons on /dev/input/event1 (Power Button) Sep 3 14:32:30.347528 systemd-logind[885]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 3 14:32:30.347746 systemd-logind[885]: New seat seat0. Sep 3 14:32:30.401098 systemd[1]: Started User Login Management. Sep 3 14:32:30.401161 dbus-daemon[872]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 3 14:32:30.439566 update_engine[892]: I0903 14:32:30.438809 892 main.cc:89] Flatcar Update Engine starting Sep 3 14:32:30.445197 systemd[1]: Started Update Engine. Sep 3 14:32:30.445405 update_engine[892]: I0903 14:32:30.445307 892 update_check_scheduler.cc:74] Next update check in 11m15s Sep 3 14:32:30.453788 systemd[1]: Started Cluster reboot manager. Sep 3 14:32:30.471460 sshd_keygen[890]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Sep 3 14:32:30.494682 systemd[1]: Finished Generate sshd host keys. Sep 3 14:32:30.500718 systemd[1]: Starting Generate /run/issue... Sep 3 14:32:30.506114 systemd[1]: issuegen.service: Deactivated successfully. Sep 3 14:32:30.506360 systemd[1]: Finished Generate /run/issue. Sep 3 14:32:30.526202 systemd[1]: Starting Permit User Sessions... Sep 3 14:32:30.538059 systemd[1]: Finished Permit User Sessions. Sep 3 14:32:30.542066 systemd[1]: Started Getty on tty1. Sep 3 14:32:30.544788 systemd[1]: Started Serial Getty on ttyS0. Sep 3 14:32:30.546509 systemd[1]: Reached target Login Prompts. Sep 3 14:32:30.548195 systemd[1]: Reached target Multi-User System. Sep 3 14:32:30.551055 systemd[1]: Starting Record Runlevel Change in UTMP... Sep 3 14:32:30.553675 locksmithd[897]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 3 14:32:30.557586 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Sep 3 14:32:30.557830 systemd[1]: Finished Record Runlevel Change in UTMP. Sep 3 14:32:30.561169 systemd[1]: Startup finished in 1.203s (kernel) + 3.618s (initrd) + 5.348s (userspace) = 10.171s. Sep 3 14:32:34.398015 systemd[1]: Created slice Slice /system/sshd. Sep 3 14:32:34.399388 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34836). Sep 3 14:32:34.475750 sshd[919]: Accepted publickey for core from 10.0.0.1 port 34836 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:34.488751 sshd[919]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:34.509239 systemd[1]: Created slice User Slice of UID 500. Sep 3 14:32:34.510445 systemd[1]: Starting User Runtime Directory /run/user/500... Sep 3 14:32:34.511994 systemd-logind[885]: New session 1 of user core. Sep 3 14:32:34.517545 systemd[1]: Finished User Runtime Directory /run/user/500. Sep 3 14:32:34.518831 systemd[1]: Starting User Manager for UID 500... Sep 3 14:32:34.525587 systemd[922]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:34.585373 systemd[922]: Queued start job for default target Main User Target. Sep 3 14:32:34.585588 systemd[922]: Reached target Paths. Sep 3 14:32:34.585601 systemd[922]: Reached target Sockets. Sep 3 14:32:34.585610 systemd[922]: Reached target Timers. Sep 3 14:32:34.585619 systemd[922]: Reached target Basic System. Sep 3 14:32:34.585689 systemd[922]: Reached target Main User Target. Sep 3 14:32:34.585700 systemd[922]: Startup finished in 52ms. Sep 3 14:32:34.585804 systemd[1]: Started User Manager for UID 500. Sep 3 14:32:34.590854 systemd[1]: Started Session 1 of User core. Sep 3 14:32:34.656730 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34844). Sep 3 14:32:34.698589 sshd[931]: Accepted publickey for core from 10.0.0.1 port 34844 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:34.700452 sshd[931]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:34.705562 systemd-logind[885]: New session 2 of user core. Sep 3 14:32:34.716205 systemd[1]: Started Session 2 of User core. Sep 3 14:32:34.789521 sshd[931]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:34.797108 systemd[1]: sshd@1-10.0.0.2:22-10.0.0.1:34844.service: Deactivated successfully. Sep 3 14:32:34.797776 systemd[1]: session-2.scope: Deactivated successfully. Sep 3 14:32:34.798340 systemd-logind[885]: Session 2 logged out. Waiting for processes to exit. Sep 3 14:32:34.799282 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34856). Sep 3 14:32:34.799834 systemd-logind[885]: Removed session 2. Sep 3 14:32:34.838127 sshd[937]: Accepted publickey for core from 10.0.0.1 port 34856 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:34.840270 sshd[937]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:34.845089 systemd-logind[885]: New session 3 of user core. Sep 3 14:32:34.855801 systemd[1]: Started Session 3 of User core. Sep 3 14:32:34.912556 sshd[937]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:34.929210 systemd[1]: sshd@2-10.0.0.2:22-10.0.0.1:34856.service: Deactivated successfully. Sep 3 14:32:34.930174 systemd[1]: session-3.scope: Deactivated successfully. Sep 3 14:32:34.930853 systemd-logind[885]: Session 3 logged out. Waiting for processes to exit. Sep 3 14:32:34.932228 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34870). Sep 3 14:32:34.932866 systemd-logind[885]: Removed session 3. Sep 3 14:32:34.970291 sshd[943]: Accepted publickey for core from 10.0.0.1 port 34870 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:34.971312 sshd[943]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:34.974145 systemd-logind[885]: New session 4 of user core. Sep 3 14:32:34.978808 systemd[1]: Started Session 4 of User core. Sep 3 14:32:35.052106 sshd[943]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:35.064274 systemd[1]: sshd@3-10.0.0.2:22-10.0.0.1:34870.service: Deactivated successfully. Sep 3 14:32:35.065094 systemd[1]: session-4.scope: Deactivated successfully. Sep 3 14:32:35.065777 systemd-logind[885]: Session 4 logged out. Waiting for processes to exit. Sep 3 14:32:35.068673 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34876). Sep 3 14:32:35.069567 systemd-logind[885]: Removed session 4. Sep 3 14:32:35.106464 sshd[949]: Accepted publickey for core from 10.0.0.1 port 34876 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:35.107433 sshd[949]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:35.110441 systemd-logind[885]: New session 5 of user core. Sep 3 14:32:35.115835 systemd[1]: Started Session 5 of User core. Sep 3 14:32:35.194462 sudo[952]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Sep 3 14:32:35.194735 sudo[952]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 3 14:32:35.208104 sudo[952]: pam_unix(sudo:session): session closed for user root Sep 3 14:32:35.212674 sshd[949]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:35.227952 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34886). Sep 3 14:32:35.231024 dbus-daemon[872]: [system] Reloaded configuration Sep 3 14:32:35.233886 systemd[1]: sshd@4-10.0.0.2:22-10.0.0.1:34876.service: Deactivated successfully. Sep 3 14:32:35.234584 systemd[1]: session-5.scope: Deactivated successfully. Sep 3 14:32:35.235361 systemd-logind[885]: Session 5 logged out. Waiting for processes to exit. Sep 3 14:32:35.236128 systemd-logind[885]: Removed session 5. Sep 3 14:32:35.268898 sshd[955]: Accepted publickey for core from 10.0.0.1 port 34886 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:35.270375 sshd[955]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:35.275437 systemd-logind[885]: New session 6 of user core. Sep 3 14:32:35.287410 systemd[1]: Started Session 6 of User core. Sep 3 14:32:35.368585 sudo[960]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Sep 3 14:32:35.368827 sudo[960]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 3 14:32:35.372614 sudo[960]: pam_unix(sudo:session): session closed for user root Sep 3 14:32:35.378773 sudo[959]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Sep 3 14:32:35.379023 sudo[959]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 3 14:32:35.402865 systemd[1]: Stopping Load Security Auditing Rules... Sep 3 14:32:35.403000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 3 14:32:35.404625 auditctl[963]: No rules Sep 3 14:32:35.404998 systemd[1]: audit-rules.service: Deactivated successfully. Sep 3 14:32:35.405226 systemd[1]: Stopped Load Security Auditing Rules. Sep 3 14:32:35.405926 kernel: kauditd_printk_skb: 62 callbacks suppressed Sep 3 14:32:35.405975 kernel: audit: type=1305 audit(1788445955.403:167): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 3 14:32:35.406626 systemd[1]: Starting Load Security Auditing Rules... Sep 3 14:32:35.404000 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' Sep 3 14:32:35.415184 kernel: audit: type=1131 audit(1788445955.404:168): 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' Sep 3 14:32:35.423798 augenrules[980]: No rules Sep 3 14:32:35.424333 systemd[1]: Finished Load Security Auditing Rules. Sep 3 14:32:35.423000 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' Sep 3 14:32:35.425152 sudo[959]: pam_unix(sudo:session): session closed for user root Sep 3 14:32:35.423000 audit[959]: USER_END pid=959 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' Sep 3 14:32:35.433589 sshd[955]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:35.436834 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34900). Sep 3 14:32:35.437204 systemd[1]: sshd@5-10.0.0.2:22-10.0.0.1:34886.service: Deactivated successfully. Sep 3 14:32:35.437759 systemd[1]: session-6.scope: Deactivated successfully. Sep 3 14:32:35.438257 systemd-logind[885]: Session 6 logged out. Waiting for processes to exit. Sep 3 14:32:35.438703 kernel: audit: type=1130 audit(1788445955.423:169): 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' Sep 3 14:32:35.439058 kernel: audit: type=1106 audit(1788445955.423:170): pid=959 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' Sep 3 14:32:35.439101 kernel: audit: type=1104 audit(1788445955.423:171): pid=959 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' Sep 3 14:32:35.423000 audit[959]: CRED_DISP pid=959 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' Sep 3 14:32:35.439048 systemd-logind[885]: Removed session 6. Sep 3 14:32:35.431000 audit[955]: USER_END pid=955 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' Sep 3 14:32:35.452187 kernel: audit: type=1106 audit(1788445955.431:172): pid=955 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' Sep 3 14:32:35.452239 kernel: audit: type=1104 audit(1788445955.431:173): pid=955 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' Sep 3 14:32:35.431000 audit[955]: CRED_DISP pid=955 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' Sep 3 14:32:35.431000 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.2:22-10.0.0.1:34900 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:35.464974 kernel: audit: type=1130 audit(1788445955.431:174): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.2:22-10.0.0.1:34900 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:35.465018 kernel: audit: type=1131 audit(1788445955.431:175): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.0.0.2:22-10.0.0.1:34886 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:35.431000 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.2:22-10.0.0.1:34886 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:35.490000 audit[985]: USER_ACCT pid=985 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' Sep 3 14:32:35.491778 sshd[985]: Accepted publickey for core from 10.0.0.1 port 34900 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:35.493149 sshd[985]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:35.496710 systemd-logind[885]: New session 7 of user core. Sep 3 14:32:35.492000 audit[985]: CRED_ACQ pid=985 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' Sep 3 14:32:35.498709 kernel: audit: type=1101 audit(1788445955.490:176): pid=985 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' Sep 3 14:32:35.506839 systemd[1]: Started Session 7 of User core. Sep 3 14:32:35.516000 audit[985]: USER_START pid=985 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' Sep 3 14:32:35.518000 audit[988]: CRED_ACQ pid=988 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' Sep 3 14:32:35.573000 audit[989]: USER_ACCT pid=989 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' Sep 3 14:32:35.573000 audit[989]: CRED_REFR pid=989 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' Sep 3 14:32:35.574199 sudo[989]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/mkdir -p . Sep 3 14:32:35.574575 sudo[989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 3 14:32:35.576000 audit[989]: USER_START pid=989 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' Sep 3 14:32:35.579168 sudo[989]: pam_unix(sudo:session): session closed for user root Sep 3 14:32:35.578000 audit[989]: USER_END pid=989 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' Sep 3 14:32:35.578000 audit[989]: CRED_DISP pid=989 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' Sep 3 14:32:35.580733 sshd[985]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:35.580000 audit[985]: USER_END pid=985 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' Sep 3 14:32:35.581000 audit[985]: CRED_DISP pid=985 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' Sep 3 14:32:35.594192 systemd[1]: sshd@6-10.0.0.2:22-10.0.0.1:34900.service: Deactivated successfully. Sep 3 14:32:35.593000 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.2:22-10.0.0.1:34900 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:35.595363 systemd[1]: session-7.scope: Deactivated successfully. Sep 3 14:32:35.596603 systemd-logind[885]: Session 7 logged out. Waiting for processes to exit. Sep 3 14:32:35.597599 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34916). Sep 3 14:32:35.597000 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.2:22-10.0.0.1:34916 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:35.598205 systemd-logind[885]: Removed session 7. Sep 3 14:32:35.640000 audit[993]: USER_ACCT pid=993 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' Sep 3 14:32:35.642130 sshd[993]: Accepted publickey for core from 10.0.0.1 port 34916 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:35.642000 audit[993]: CRED_ACQ pid=993 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' Sep 3 14:32:35.643177 sshd[993]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:35.647554 systemd-logind[885]: New session 8 of user core. Sep 3 14:32:35.654697 systemd[1]: Started Session 8 of User core. Sep 3 14:32:35.662000 audit[993]: USER_START pid=993 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' Sep 3 14:32:35.664000 audit[995]: CRED_ACQ pid=995 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' Sep 3 14:32:35.718000 audit[996]: USER_ACCT pid=996 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' Sep 3 14:32:35.718000 audit[996]: CRED_REFR pid=996 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' Sep 3 14:32:35.719908 sudo[996]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/install -m 0755 /dev/stdin kolet Sep 3 14:32:35.720165 sudo[996]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 3 14:32:35.722000 audit[996]: USER_START pid=996 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' Sep 3 14:32:36.030000 audit[996]: USER_END pid=996 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' Sep 3 14:32:36.030000 audit[996]: CRED_DISP pid=996 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' Sep 3 14:32:36.030628 sudo[996]: pam_unix(sudo:session): session closed for user root Sep 3 14:32:36.032089 sshd[993]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:36.032000 audit[993]: USER_END pid=993 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' Sep 3 14:32:36.032000 audit[993]: CRED_DISP 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' Sep 3 14:32:36.039264 systemd[1]: sshd@7-10.0.0.2:22-10.0.0.1:34916.service: Deactivated successfully. Sep 3 14:32:36.037000 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.2:22-10.0.0.1:34916 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:36.039902 systemd[1]: session-8.scope: Deactivated successfully. Sep 3 14:32:36.040436 systemd-logind[885]: Session 8 logged out. Waiting for processes to exit. Sep 3 14:32:36.041462 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34918). Sep 3 14:32:36.039000 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.2:22-10.0.0.1:34918 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:36.042042 systemd-logind[885]: Removed session 8. Sep 3 14:32:36.078000 audit[1000]: USER_ACCT pid=1000 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' Sep 3 14:32:36.081601 sshd[1000]: Accepted publickey for core from 10.0.0.1 port 34918 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:36.082000 audit[1000]: CRED_ACQ pid=1000 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' Sep 3 14:32:36.084535 sshd[1000]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:36.089876 systemd-logind[885]: New session 9 of user core. Sep 3 14:32:36.094810 systemd[1]: Started Session 9 of User core. Sep 3 14:32:36.097000 audit[1000]: USER_START pid=1000 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' Sep 3 14:32:36.098000 audit[1002]: CRED_ACQ pid=1002 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' Sep 3 14:32:36.146000 audit[1003]: USER_ACCT pid=1003 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' Sep 3 14:32:36.147354 sudo[1003]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/mkdir -p /updates Sep 3 14:32:36.146000 audit[1003]: CRED_REFR pid=1003 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' Sep 3 14:32:36.147592 sudo[1003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 3 14:32:36.148000 audit[1003]: USER_START pid=1003 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' Sep 3 14:32:36.150286 sudo[1003]: pam_unix(sudo:session): session closed for user root Sep 3 14:32:36.149000 audit[1003]: USER_END pid=1003 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' Sep 3 14:32:36.149000 audit[1003]: CRED_DISP pid=1003 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' Sep 3 14:32:36.151523 sshd[1000]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:36.151000 audit[1000]: USER_END pid=1000 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' Sep 3 14:32:36.151000 audit[1000]: CRED_DISP 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' Sep 3 14:32:36.156968 systemd[1]: sshd@8-10.0.0.2:22-10.0.0.1:34918.service: Deactivated successfully. Sep 3 14:32:36.156000 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.2:22-10.0.0.1:34918 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:36.157508 systemd[1]: session-9.scope: Deactivated successfully. Sep 3 14:32:36.158039 systemd-logind[885]: Session 9 logged out. Waiting for processes to exit. Sep 3 14:32:36.159057 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:34930). Sep 3 14:32:36.158000 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.2:22-10.0.0.1:34930 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:36.159848 systemd-logind[885]: Removed session 9. Sep 3 14:32:36.195000 audit[1007]: USER_ACCT pid=1007 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' Sep 3 14:32:36.195932 sshd[1007]: Accepted publickey for core from 10.0.0.1 port 34930 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:36.195000 audit[1007]: CRED_ACQ pid=1007 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' Sep 3 14:32:36.196759 sshd[1007]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:36.199194 systemd-logind[885]: New session 10 of user core. Sep 3 14:32:36.204831 systemd[1]: Started Session 10 of User core. Sep 3 14:32:36.207000 audit[1007]: USER_START pid=1007 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' Sep 3 14:32:36.208000 audit[1009]: CRED_ACQ pid=1009 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' Sep 3 14:32:36.261000 audit[1010]: USER_ACCT pid=1010 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' Sep 3 14:32:36.262000 audit[1010]: CRED_REFR pid=1010 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' Sep 3 14:32:36.263639 sudo[1010]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/install -m 0755 /dev/stdin /updates/update.gz Sep 3 14:32:36.263869 sudo[1010]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 3 14:32:36.264000 audit[1010]: USER_START pid=1010 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' Sep 3 14:32:38.789909 sudo[1010]: pam_unix(sudo:session): session closed for user root Sep 3 14:32:38.789000 audit[1010]: USER_END pid=1010 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' Sep 3 14:32:38.789000 audit[1010]: CRED_DISP pid=1010 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' Sep 3 14:32:38.792246 sshd[1007]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:38.793000 audit[1007]: USER_END pid=1007 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' Sep 3 14:32:38.793000 audit[1007]: CRED_DISP 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' Sep 3 14:32:38.803705 systemd[1]: sshd@9-10.0.0.2:22-10.0.0.1:34930.service: Deactivated successfully. Sep 3 14:32:38.803000 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.2:22-10.0.0.1:34930 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:38.804518 systemd[1]: session-10.scope: Deactivated successfully. Sep 3 14:32:38.804853 systemd[1]: session-10.scope: Consumed 3.546s CPU time. Sep 3 14:32:38.805671 systemd-logind[885]: Session 10 logged out. Waiting for processes to exit. Sep 3 14:32:38.807052 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33566). Sep 3 14:32:38.806000 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.2:22-10.0.0.1:33566 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:38.807777 systemd-logind[885]: Removed session 10. Sep 3 14:32:38.856000 audit[1014]: USER_ACCT pid=1014 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' Sep 3 14:32:38.858008 sshd[1014]: Accepted publickey for core from 10.0.0.1 port 33566 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:38.857000 audit[1014]: CRED_ACQ pid=1014 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' Sep 3 14:32:38.859221 sshd[1014]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:38.864854 systemd-logind[885]: New session 11 of user core. Sep 3 14:32:38.868821 systemd[1]: Started Session 11 of User core. Sep 3 14:32:38.871000 audit[1014]: USER_START pid=1014 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' Sep 3 14:32:38.872000 audit[1016]: CRED_ACQ pid=1016 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' Sep 3 14:32:38.921000 audit[1017]: USER_ACCT pid=1017 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' Sep 3 14:32:38.921000 audit[1017]: CRED_REFR pid=1017 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' Sep 3 14:32:38.922224 sudo[1017]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemd-run --quiet ./kolet run cl.update.payload-boot-part-too-small Omaha Sep 3 14:32:38.922454 sudo[1017]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 3 14:32:38.923000 audit[1017]: USER_START pid=1017 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' Sep 3 14:32:38.938807 systemd[1]: Started /home/core/./kolet run cl.update.payload-boot-part-too-small Omaha. Sep 3 14:32:38.938000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=run-ra13c29ffb93140d3af60ab87a08291de comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:38.939587 sudo[1017]: pam_unix(sudo:session): session closed for user root Sep 3 14:32:38.938000 audit[1017]: USER_END pid=1017 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' Sep 3 14:32:38.939000 audit[1017]: CRED_DISP pid=1017 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' Sep 3 14:32:38.943710 sshd[1014]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:38.945000 audit[1014]: USER_END pid=1014 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' Sep 3 14:32:38.946000 audit[1014]: CRED_DISP 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' Sep 3 14:32:38.947195 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:33582). Sep 3 14:32:38.946000 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.2:22-10.0.0.1:33582 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:38.950075 systemd[1]: sshd@10-10.0.0.2:22-10.0.0.1:33566.service: Deactivated successfully. Sep 3 14:32:38.948000 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.2:22-10.0.0.1:33566 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:38.950578 systemd[1]: session-11.scope: Deactivated successfully. Sep 3 14:32:38.951373 systemd-logind[885]: Session 11 logged out. Waiting for processes to exit. Sep 3 14:32:38.952464 systemd-logind[885]: Removed session 11. Sep 3 14:32:38.988000 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' Sep 3 14:32:38.990470 sshd[1024]: Accepted publickey for core from 10.0.0.1 port 33582 ssh2: RSA SHA256:AdDvqkFJy+n4YrHVvaL1ir2FbaFIHxYDwBARG2dsnBw Sep 3 14:32:38.998000 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' Sep 3 14:32:39.001545 sshd[1024]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 3 14:32:39.019189 systemd-logind[885]: New session 12 of user core. Sep 3 14:32:39.041909 systemd[1]: Started Session 12 of User core. Sep 3 14:32:39.047000 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' Sep 3 14:32:39.048000 audit[1031]: CRED_ACQ pid=1031 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' Sep 3 14:32:40.136468 sshd[1024]: pam_unix(sshd:session): session closed for user core Sep 3 14:32:40.138000 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' Sep 3 14:32:40.138000 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' Sep 3 14:32:40.141796 systemd[1]: sshd@11-10.0.0.2:22-10.0.0.1:33582.service: Deactivated successfully. Sep 3 14:32:40.141000 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.2:22-10.0.0.1:33582 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 14:32:40.144916 systemd[1]: session-12.scope: Deactivated successfully. Sep 3 14:32:40.146464 systemd-logind[885]: Session 12 logged out. Waiting for processes to exit. Sep 3 14:32:40.148258 systemd-logind[885]: Removed session 12. Sep 3 14:33:15.426903 update_engine[892]: I0903 14:33:15.426124 892 update_attempter.cc:505] Updating boot flags...