Jun 4 23:51:08.404640 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 Jun 4 23:51:08.404667 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 Jun 4 23:51:08.404676 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jun 4 23:51:08.404681 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jun 4 23:51:08.404687 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jun 4 23:51:08.404692 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Jun 4 23:51:08.404698 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Jun 4 23:51:08.404704 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Jun 4 23:51:08.404712 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jun 4 23:51:08.404717 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Jun 4 23:51:08.404723 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Jun 4 23:51:08.404729 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Jun 4 23:51:08.404736 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format. Jun 4 23:51:08.404743 kernel: BIOS-provided physical RAM map: Jun 4 23:51:08.404751 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Jun 4 23:51:08.404759 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Jun 4 23:51:08.404765 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Jun 4 23:51:08.404770 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Jun 4 23:51:08.404776 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Jun 4 23:51:08.404782 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Jun 4 23:51:08.404787 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Jun 4 23:51:08.404793 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jun 4 23:51:08.404835 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Jun 4 23:51:08.404842 kernel: NX (Execute Disable) protection: active Jun 4 23:51:08.404848 kernel: SMBIOS 2.8 present. Jun 4 23:51:08.404853 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Jun 4 23:51:08.404862 kernel: Hypervisor detected: KVM Jun 4 23:51:08.404868 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jun 4 23:51:08.404873 kernel: kvm-clock: cpu 0, msr 336ba001, primary cpu clock Jun 4 23:51:08.404879 kernel: kvm-clock: using sched offset of 25348342871 cycles Jun 4 23:51:08.404885 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jun 4 23:51:08.404892 kernel: tsc: Detected 2793.438 MHz processor Jun 4 23:51:08.404899 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jun 4 23:51:08.404908 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jun 4 23:51:08.404915 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x10000000000 Jun 4 23:51:08.404921 kernel: MTRR default type: write-back Jun 4 23:51:08.404929 kernel: MTRR fixed ranges enabled: Jun 4 23:51:08.404935 kernel: 00000-9FFFF write-back Jun 4 23:51:08.404941 kernel: A0000-BFFFF uncachable Jun 4 23:51:08.404947 kernel: C0000-FFFFF write-protect Jun 4 23:51:08.404956 kernel: MTRR variable ranges enabled: Jun 4 23:51:08.404963 kernel: 0 base 0000C0000000 mask 3FFFC0000000 uncachable Jun 4 23:51:08.404969 kernel: 1 disabled Jun 4 23:51:08.404975 kernel: 2 disabled Jun 4 23:51:08.404982 kernel: 3 disabled Jun 4 23:51:08.404992 kernel: 4 disabled Jun 4 23:51:08.404997 kernel: 5 disabled Jun 4 23:51:08.405003 kernel: 6 disabled Jun 4 23:51:08.405009 kernel: 7 disabled Jun 4 23:51:08.405015 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jun 4 23:51:08.405021 kernel: Using GB pages for direct mapping Jun 4 23:51:08.405028 kernel: ACPI: Early table checksum verification disabled Jun 4 23:51:08.405034 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Jun 4 23:51:08.405040 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:51:08.405049 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:51:08.405055 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:51:08.405063 kernel: ACPI: FACS 0x000000009CFE0000 000040 Jun 4 23:51:08.405071 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:51:08.405078 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:51:08.405084 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:51:08.405091 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 4 23:51:08.405097 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Jun 4 23:51:08.405106 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Jun 4 23:51:08.405112 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Jun 4 23:51:08.405118 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Jun 4 23:51:08.405124 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Jun 4 23:51:08.405130 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Jun 4 23:51:08.405136 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Jun 4 23:51:08.405143 kernel: ACPI: Local APIC address 0xfee00000 Jun 4 23:51:08.405181 kernel: No NUMA configuration found Jun 4 23:51:08.405188 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Jun 4 23:51:08.405197 kernel: NODE_DATA(0) allocated [mem 0x9cfd6000-0x9cfdbfff] Jun 4 23:51:08.405204 kernel: Zone ranges: Jun 4 23:51:08.405210 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jun 4 23:51:08.405216 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Jun 4 23:51:08.405223 kernel: Normal empty Jun 4 23:51:08.405230 kernel: Movable zone start for each node Jun 4 23:51:08.405238 kernel: Early memory node ranges Jun 4 23:51:08.405246 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Jun 4 23:51:08.405252 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Jun 4 23:51:08.405258 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Jun 4 23:51:08.405267 kernel: On node 0 totalpages: 642938 Jun 4 23:51:08.405273 kernel: DMA zone: 64 pages used for memmap Jun 4 23:51:08.405279 kernel: DMA zone: 21 pages reserved Jun 4 23:51:08.405285 kernel: DMA zone: 3998 pages, LIFO batch:0 Jun 4 23:51:08.405291 kernel: DMA32 zone: 9984 pages used for memmap Jun 4 23:51:08.405298 kernel: DMA32 zone: 638940 pages, LIFO batch:63 Jun 4 23:51:08.405304 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jun 4 23:51:08.405310 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Jun 4 23:51:08.405318 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Jun 4 23:51:08.405325 kernel: ACPI: PM-Timer IO Port: 0x608 Jun 4 23:51:08.405334 kernel: ACPI: Local APIC address 0xfee00000 Jun 4 23:51:08.405340 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jun 4 23:51:08.405346 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jun 4 23:51:08.405353 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jun 4 23:51:08.405359 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jun 4 23:51:08.405365 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jun 4 23:51:08.405371 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jun 4 23:51:08.405377 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jun 4 23:51:08.405383 kernel: ACPI: IRQ0 used by override. Jun 4 23:51:08.405393 kernel: ACPI: IRQ5 used by override. Jun 4 23:51:08.405440 kernel: ACPI: IRQ9 used by override. Jun 4 23:51:08.405448 kernel: ACPI: IRQ10 used by override. Jun 4 23:51:08.405454 kernel: ACPI: IRQ11 used by override. Jun 4 23:51:08.405460 kernel: Using ACPI (MADT) for SMP configuration information Jun 4 23:51:08.405536 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jun 4 23:51:08.405543 kernel: TSC deadline timer available Jun 4 23:51:08.405549 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Jun 4 23:51:08.405556 kernel: kvm-guest: KVM setup pv remote TLB flush Jun 4 23:51:08.405562 kernel: kvm-guest: setup PV sched yield Jun 4 23:51:08.405573 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Jun 4 23:51:08.405581 kernel: Booting paravirtualized kernel on KVM Jun 4 23:51:08.405589 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jun 4 23:51:08.405595 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:4 nr_node_ids:1 Jun 4 23:51:08.405601 kernel: percpu: Embedded 58 pages/cpu s199704 r8192 d29672 u524288 Jun 4 23:51:08.405607 kernel: pcpu-alloc: s199704 r8192 d29672 u524288 alloc=1*2097152 Jun 4 23:51:08.405649 kernel: pcpu-alloc: [0] 0 1 2 3 Jun 4 23:51:08.405656 kernel: kvm-guest: KVM setup async PF for cpu 0 Jun 4 23:51:08.405673 kernel: kvm-guest: stealtime: cpu 0, msr 9a41c580 Jun 4 23:51:08.405682 kernel: kvm-guest: PV spinlocks enabled Jun 4 23:51:08.405688 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jun 4 23:51:08.405695 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632869 Jun 4 23:51:08.405701 kernel: Policy zone: DMA32 Jun 4 23:51:08.405709 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 Jun 4 23:51:08.405716 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jun 4 23:51:08.405723 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jun 4 23:51:08.405732 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jun 4 23:51:08.405740 kernel: Memory: 2448560K/2571752K available (10246K kernel code, 2239K rwdata, 11640K rodata, 42228K init, 1436K bss, 122988K reserved, 0K cma-reserved) Jun 4 23:51:08.405748 kernel: random: get_random_u64 called from __kmem_cache_create+0x26/0x400 with crng_init=0 Jun 4 23:51:08.405756 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jun 4 23:51:08.405763 kernel: ftrace: allocating 34378 entries in 135 pages Jun 4 23:51:08.405770 kernel: ftrace: allocated 135 pages with 4 groups Jun 4 23:51:08.405776 kernel: rcu: Hierarchical RCU implementation. Jun 4 23:51:08.405783 kernel: rcu: RCU event tracing is enabled. Jun 4 23:51:08.405790 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jun 4 23:51:08.405800 kernel: Rude variant of Tasks RCU enabled. Jun 4 23:51:08.405806 kernel: Tracing variant of Tasks RCU enabled. Jun 4 23:51:08.405813 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jun 4 23:51:08.405819 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jun 4 23:51:08.405826 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Jun 4 23:51:08.405834 kernel: Console: colour VGA+ 80x25 Jun 4 23:51:08.405841 kernel: printk: console [ttyS0] enabled Jun 4 23:51:08.405848 kernel: ACPI: Core revision 20200925 Jun 4 23:51:08.405854 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jun 4 23:51:08.405864 kernel: APIC: Switch to symmetric I/O mode setup Jun 4 23:51:08.405870 kernel: x2apic enabled Jun 4 23:51:08.405877 kernel: Switched APIC routing to physical x2apic. Jun 4 23:51:08.405883 kernel: kvm-guest: setup PV IPIs Jun 4 23:51:08.405890 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jun 4 23:51:08.405896 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Jun 4 23:51:08.405903 kernel: Calibrating delay loop (skipped) preset value.. 5586.87 BogoMIPS (lpj=2793438) Jun 4 23:51:08.405911 kernel: pid_max: default: 32768 minimum: 301 Jun 4 23:51:08.405919 kernel: LSM: Security Framework initializing Jun 4 23:51:08.405928 kernel: SELinux: Initializing. Jun 4 23:51:08.405935 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 4 23:51:08.405942 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 4 23:51:08.405948 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jun 4 23:51:08.405955 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Jun 4 23:51:08.405961 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Jun 4 23:51:08.405970 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jun 4 23:51:08.405977 kernel: Spectre V2 : Mitigation: Retpolines Jun 4 23:51:08.405983 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Jun 4 23:51:08.406024 kernel: Speculative Store Bypass: Vulnerable Jun 4 23:51:08.406032 kernel: Freeing SMP alternatives memory: 28K Jun 4 23:51:08.406038 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz (family: 0x6, model: 0x6a, stepping: 0x6) Jun 4 23:51:08.406045 kernel: Performance Events: unsupported p6 CPU model 106 no PMU driver, software events only. Jun 4 23:51:08.406052 kernel: rcu: Hierarchical SRCU implementation. Jun 4 23:51:08.406059 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Jun 4 23:51:08.406069 kernel: smp: Bringing up secondary CPUs ... Jun 4 23:51:08.406077 kernel: x86: Booting SMP configuration: Jun 4 23:51:08.406084 kernel: .... node #0, CPUs: #1 Jun 4 23:51:08.406091 kernel: kvm-clock: cpu 1, msr 336ba041, secondary cpu clock Jun 4 23:51:08.406098 kernel: kvm-guest: KVM setup async PF for cpu 1 Jun 4 23:51:08.406104 kernel: kvm-guest: stealtime: cpu 1, msr 9a49c580 Jun 4 23:51:08.406111 kernel: #2 Jun 4 23:51:08.406117 kernel: kvm-clock: cpu 2, msr 336ba081, secondary cpu clock Jun 4 23:51:08.406124 kernel: kvm-guest: KVM setup async PF for cpu 2 Jun 4 23:51:08.406130 kernel: kvm-guest: stealtime: cpu 2, msr 9a51c580 Jun 4 23:51:08.406139 kernel: #3 Jun 4 23:51:08.406146 kernel: kvm-clock: cpu 3, msr 336ba0c1, secondary cpu clock Jun 4 23:51:08.406152 kernel: kvm-guest: KVM setup async PF for cpu 3 Jun 4 23:51:08.406160 kernel: kvm-guest: stealtime: cpu 3, msr 9a59c580 Jun 4 23:51:08.406167 kernel: smp: Brought up 1 node, 4 CPUs Jun 4 23:51:08.406174 kernel: smpboot: Max logical packages: 1 Jun 4 23:51:08.406181 kernel: smpboot: Total of 4 processors activated (22347.50 BogoMIPS) Jun 4 23:51:08.406187 kernel: devtmpfs: initialized Jun 4 23:51:08.406194 kernel: x86/mm: Memory block size: 128MB Jun 4 23:51:08.406203 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jun 4 23:51:08.406209 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jun 4 23:51:08.406216 kernel: pinctrl core: initialized pinctrl subsystem Jun 4 23:51:08.406223 kernel: NET: Registered protocol family 16 Jun 4 23:51:08.406229 kernel: audit: initializing netlink subsys (disabled) Jun 4 23:51:08.406237 kernel: audit: type=2000 audit(1780617059.306:1): state=initialized audit_enabled=0 res=1 Jun 4 23:51:08.406245 kernel: thermal_sys: Registered thermal governor 'step_wise' Jun 4 23:51:08.406253 kernel: thermal_sys: Registered thermal governor 'user_space' Jun 4 23:51:08.406259 kernel: cpuidle: using governor menu Jun 4 23:51:08.406266 kernel: ACPI: bus type PCI registered Jun 4 23:51:08.406275 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jun 4 23:51:08.406281 kernel: dca service started, version 1.12.1 Jun 4 23:51:08.406288 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Jun 4 23:51:08.406295 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved in E820 Jun 4 23:51:08.406301 kernel: PCI: Using configuration type 1 for base access Jun 4 23:51:08.406308 kernel: Kprobes globally optimized Jun 4 23:51:08.406314 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Jun 4 23:51:08.406321 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Jun 4 23:51:08.406329 kernel: ACPI: Added _OSI(Module Device) Jun 4 23:51:08.406339 kernel: ACPI: Added _OSI(Processor Device) Jun 4 23:51:08.406345 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jun 4 23:51:08.406352 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jun 4 23:51:08.406358 kernel: ACPI: Added _OSI(Linux-Dell-Video) Jun 4 23:51:08.406364 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Jun 4 23:51:08.406371 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Jun 4 23:51:08.406377 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jun 4 23:51:08.406384 kernel: ACPI: Interpreter enabled Jun 4 23:51:08.406390 kernel: ACPI: (supports S0 S3 S5) Jun 4 23:51:08.406397 kernel: ACPI: Using IOAPIC for interrupt routing Jun 4 23:51:08.406447 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jun 4 23:51:08.406454 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jun 4 23:51:08.406460 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jun 4 23:51:08.406841 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jun 4 23:51:08.406922 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Jun 4 23:51:08.407000 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Jun 4 23:51:08.407010 kernel: PCI host bridge to bus 0000:00 Jun 4 23:51:08.407097 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jun 4 23:51:08.407168 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jun 4 23:51:08.407231 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jun 4 23:51:08.407296 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Jun 4 23:51:08.407361 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jun 4 23:51:08.407535 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Jun 4 23:51:08.407610 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jun 4 23:51:08.407700 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Jun 4 23:51:08.408659 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Jun 4 23:51:08.408743 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Jun 4 23:51:08.408819 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Jun 4 23:51:08.408915 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Jun 4 23:51:08.409039 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Jun 4 23:51:08.409115 kernel: pci 0000:00:02.0: reg 0x10: [io 0xc0c0-0xc0df] Jun 4 23:51:08.409237 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Jun 4 23:51:08.409310 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Jun 4 23:51:08.409546 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Jun 4 23:51:08.409629 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc07f] Jun 4 23:51:08.409703 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Jun 4 23:51:08.409775 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Jun 4 23:51:08.409892 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Jun 4 23:51:08.409968 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc0e0-0xc0ff] Jun 4 23:51:08.410038 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Jun 4 23:51:08.410109 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Jun 4 23:51:08.410181 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Jun 4 23:51:08.410298 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Jun 4 23:51:08.410369 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jun 4 23:51:08.410586 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Jun 4 23:51:08.410664 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc100-0xc11f] Jun 4 23:51:08.410733 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfebd4000-0xfebd4fff] Jun 4 23:51:08.410848 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Jun 4 23:51:08.410919 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] Jun 4 23:51:08.410930 kernel: ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) Jun 4 23:51:08.410939 kernel: ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) Jun 4 23:51:08.410946 kernel: ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) Jun 4 23:51:08.410957 kernel: ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) Jun 4 23:51:08.410964 kernel: ACPI: PCI Interrupt Link [LNKE] (IRQs 5 *10 11) Jun 4 23:51:08.410971 kernel: ACPI: PCI Interrupt Link [LNKF] (IRQs 5 *10 11) Jun 4 23:51:08.410977 kernel: ACPI: PCI Interrupt Link [LNKG] (IRQs 5 10 *11) Jun 4 23:51:08.410984 kernel: ACPI: PCI Interrupt Link [LNKH] (IRQs 5 10 *11) Jun 4 23:51:08.410990 kernel: ACPI: PCI Interrupt Link [GSIA] (IRQs *16) Jun 4 23:51:08.410997 kernel: ACPI: PCI Interrupt Link [GSIB] (IRQs *17) Jun 4 23:51:08.411004 kernel: ACPI: PCI Interrupt Link [GSIC] (IRQs *18) Jun 4 23:51:08.411012 kernel: ACPI: PCI Interrupt Link [GSID] (IRQs *19) Jun 4 23:51:08.411020 kernel: ACPI: PCI Interrupt Link [GSIE] (IRQs *20) Jun 4 23:51:08.411029 kernel: ACPI: PCI Interrupt Link [GSIF] (IRQs *21) Jun 4 23:51:08.411036 kernel: ACPI: PCI Interrupt Link [GSIG] (IRQs *22) Jun 4 23:51:08.411042 kernel: ACPI: PCI Interrupt Link [GSIH] (IRQs *23) Jun 4 23:51:08.411049 kernel: iommu: Default domain type: Translated Jun 4 23:51:08.411122 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jun 4 23:51:08.411193 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jun 4 23:51:08.411261 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jun 4 23:51:08.411272 kernel: vgaarb: loaded Jun 4 23:51:08.411283 kernel: PCI: Using ACPI for IRQ routing Jun 4 23:51:08.411291 kernel: PCI: pci_cache_line_size set to 64 bytes Jun 4 23:51:08.411298 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Jun 4 23:51:08.411305 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Jun 4 23:51:08.411311 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jun 4 23:51:08.411318 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jun 4 23:51:08.411325 kernel: clocksource: Switched to clocksource kvm-clock Jun 4 23:51:08.411333 kernel: VFS: Disk quotas dquot_6.6.0 Jun 4 23:51:08.411340 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jun 4 23:51:08.411347 kernel: pnp: PnP ACPI init Jun 4 23:51:08.411765 kernel: pnp 00:00: Plug and Play ACPI device, IDs PNP0303 (active) Jun 4 23:51:08.411943 kernel: pnp 00:01: Plug and Play ACPI device, IDs PNP0f13 (active) Jun 4 23:51:08.412090 kernel: pnp 00:02: Plug and Play ACPI device, IDs PNP0400 (active) Jun 4 23:51:08.412236 kernel: pnp 00:03: Plug and Play ACPI device, IDs PNP0501 (active) Jun 4 23:51:08.412324 kernel: pnp 00:04: Plug and Play ACPI device, IDs PNP0b00 (active) Jun 4 23:51:08.412542 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Jun 4 23:51:08.412619 kernel: system 00:05: Plug and Play ACPI device, IDs PNP0c01 (active) Jun 4 23:51:08.412629 kernel: pnp: PnP ACPI: found 6 devices Jun 4 23:51:08.412636 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jun 4 23:51:08.412643 kernel: NET: Registered protocol family 2 Jun 4 23:51:08.412650 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jun 4 23:51:08.412658 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jun 4 23:51:08.412665 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jun 4 23:51:08.412676 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Jun 4 23:51:08.412684 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jun 4 23:51:08.412692 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 4 23:51:08.412698 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 4 23:51:08.412705 kernel: NET: Registered protocol family 1 Jun 4 23:51:08.412712 kernel: NET: Registered protocol family 44 Jun 4 23:51:08.412785 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jun 4 23:51:08.412846 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jun 4 23:51:08.412912 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jun 4 23:51:08.412978 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Jun 4 23:51:08.413042 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Jun 4 23:51:08.413103 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Jun 4 23:51:08.413174 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jun 4 23:51:08.413184 kernel: PCI: CLS 0 bytes, default 64 Jun 4 23:51:08.413191 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Jun 4 23:51:08.413199 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Jun 4 23:51:08.413208 kernel: Initialise system trusted keyrings Jun 4 23:51:08.413219 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jun 4 23:51:08.413225 kernel: hrtimer: interrupt took 5507572 ns Jun 4 23:51:08.413232 kernel: Key type asymmetric registered Jun 4 23:51:08.413239 kernel: Asymmetric key parser 'x509' registered Jun 4 23:51:08.413246 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Jun 4 23:51:08.413253 kernel: io scheduler mq-deadline registered Jun 4 23:51:08.413260 kernel: io scheduler kyber registered Jun 4 23:51:08.413266 kernel: io scheduler bfq registered Jun 4 23:51:08.413273 kernel: intel_idle: Please enable MWAIT in BIOS SETUP Jun 4 23:51:08.413280 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jun 4 23:51:08.413291 kernel: PCI Interrupt Link [GSIG] enabled at IRQ 22 Jun 4 23:51:08.413299 kernel: PCI Interrupt Link [GSIH] enabled at IRQ 23 Jun 4 23:51:08.413306 kernel: PCI Interrupt Link [GSIE] enabled at IRQ 20 Jun 4 23:51:08.413312 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jun 4 23:51:08.413319 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jun 4 23:51:08.413326 kernel: random: fast init done Jun 4 23:51:08.413333 kernel: random: crng init done Jun 4 23:51:08.413340 kernel: wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information. Jun 4 23:51:08.413346 kernel: wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld . All Rights Reserved. Jun 4 23:51:08.413356 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jun 4 23:51:08.413364 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jun 4 23:51:08.413372 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jun 4 23:51:08.413549 kernel: rtc_cmos 00:04: RTC can wake from S4 Jun 4 23:51:08.413561 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jun 4 23:51:08.413624 kernel: rtc_cmos 00:04: registered as rtc0 Jun 4 23:51:08.413691 kernel: rtc_cmos 00:04: setting system clock to 2026-06-04T23:51:07 UTC (1780617067) Jun 4 23:51:08.413755 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Jun 4 23:51:08.413768 kernel: intel_pstate: CPU model not supported Jun 4 23:51:08.413775 kernel: NET: Registered protocol family 10 Jun 4 23:51:08.413782 kernel: Segment Routing with IPv6 Jun 4 23:51:08.413789 kernel: NET: Registered protocol family 17 Jun 4 23:51:08.413796 kernel: Key type dns_resolver registered Jun 4 23:51:08.413802 kernel: IPI shorthand broadcast: enabled Jun 4 23:51:08.413810 kernel: sched_clock: Marking stable (6068825405, 1574711362)->(8968290026, -1324753259) Jun 4 23:51:08.413818 kernel: registered taskstats version 1 Jun 4 23:51:08.413827 kernel: Loading compiled-in X.509 certificates Jun 4 23:51:08.413845 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.10.107-flatcar: 5866c780451a04cc08b278527846e2b48fb1aa10' Jun 4 23:51:08.413863 kernel: Key type ._fscrypt registered Jun 4 23:51:08.413870 kernel: Key type .fscrypt registered Jun 4 23:51:08.413877 kernel: Key type fscrypt-provisioning registered Jun 4 23:51:08.413887 kernel: ima: No TPM chip found, activating TPM-bypass! Jun 4 23:51:08.413894 kernel: ima: Allocated hash algorithm: sha1 Jun 4 23:51:08.413902 kernel: ima: No architecture policies found Jun 4 23:51:08.413910 kernel: Freeing unused kernel image (initmem) memory: 42228K Jun 4 23:51:08.413918 kernel: Write protecting the kernel read-only data: 24576k Jun 4 23:51:08.413925 kernel: Freeing unused kernel image (text/rodata gap) memory: 2040K Jun 4 23:51:08.413932 kernel: Freeing unused kernel image (rodata/data gap) memory: 648K Jun 4 23:51:08.413938 kernel: Run /init as init process Jun 4 23:51:08.413945 kernel: with arguments: Jun 4 23:51:08.413955 kernel: /init Jun 4 23:51:08.413962 kernel: with environment: Jun 4 23:51:08.413968 kernel: HOME=/ Jun 4 23:51:08.413975 kernel: TERM=linux Jun 4 23:51:08.413983 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jun 4 23:51:08.413994 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) Jun 4 23:51:08.414004 systemd[1]: Detected virtualization kvm. Jun 4 23:51:08.414012 systemd[1]: Detected architecture x86-64. Jun 4 23:51:08.414022 systemd[1]: Running in initial RAM disk. Jun 4 23:51:08.414029 systemd[1]: No hostname configured, using default hostname. Jun 4 23:51:08.414036 systemd[1]: Hostname set to . Jun 4 23:51:08.414044 systemd[1]: Initializing machine ID from VM UUID. Jun 4 23:51:08.414052 systemd[1]: Queued start job for default target Initrd Default Target. Jun 4 23:51:08.414059 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Jun 4 23:51:08.414067 systemd[1]: Reached target Local Encrypted Volumes. Jun 4 23:51:08.414076 systemd[1]: Reached target Path Units. Jun 4 23:51:08.414083 systemd[1]: Reached target Slice Units. Jun 4 23:51:08.414093 systemd[1]: Reached target Swaps. Jun 4 23:51:08.414100 systemd[1]: Reached target Timer Units. Jun 4 23:51:08.414108 systemd[1]: Listening on Open-iSCSI iscsid Socket. Jun 4 23:51:08.414115 systemd[1]: Listening on Open-iSCSI iscsiuio Socket. Jun 4 23:51:08.414123 systemd[1]: Listening on Journal Audit Socket. Jun 4 23:51:08.414130 systemd[1]: Listening on Journal Socket (/dev/log). Jun 4 23:51:08.414138 systemd[1]: Listening on Journal Socket. Jun 4 23:51:08.414146 systemd[1]: Listening on Network Service Netlink Socket. Jun 4 23:51:08.414159 systemd[1]: Listening on udev Control Socket. Jun 4 23:51:08.414167 systemd[1]: Listening on udev Kernel Socket. Jun 4 23:51:08.414174 systemd[1]: Reached target Socket Units. Jun 4 23:51:08.414181 systemd[1]: Starting Create List of Static Device Nodes... Jun 4 23:51:08.414189 systemd[1]: Finished Network Cleanup. Jun 4 23:51:08.414196 systemd[1]: Started Hardware RNG Entropy Gatherer Daemon. Jun 4 23:51:08.414203 systemd[1]: Starting Journal Service... Jun 4 23:51:08.414210 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Jun 4 23:51:08.414218 systemd[1]: Starting Apply Kernel Variables... Jun 4 23:51:08.414229 systemd[1]: Starting Setup Virtual Console... Jun 4 23:51:08.414237 systemd[1]: Finished Create List of Static Device Nodes. Jun 4 23:51:08.414249 systemd-journald[191]: Journal started Jun 4 23:51:08.414301 systemd-journald[191]: Runtime Journal (/run/log/journal/477609d1e66a4eed9ba14c01cdbaa162) is 6.0M, max 48.7M, 42.6M free. Jun 4 23:51:08.800000 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' Jun 4 23:51:08.818698 kernel: audit: type=1130 audit(1780617068.800: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' Jun 4 23:51:08.818941 systemd[1]: Started Journal Service. Jun 4 23:51:08.825000 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' Jun 4 23:51:08.826990 systemd[1]: Finished Apply Kernel Variables. Jun 4 23:51:08.868464 kernel: audit: type=1130 audit(1780617068.825:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:51:08.868626 kernel: audit: type=1130 audit(1780617068.842:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:51:08.842000 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' Jun 4 23:51:08.844785 systemd[1]: Finished Setup Virtual Console. Jun 4 23:51:08.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' Jun 4 23:51:08.890774 systemd[1]: Starting dracut ask for additional cmdline parameters... Jun 4 23:51:08.942352 kernel: audit: type=1130 audit(1780617068.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' Jun 4 23:51:08.943833 systemd[1]: Starting Create Static Device Nodes in /dev... Jun 4 23:51:08.952255 systemd[1]: Finished Create Static Device Nodes in /dev. Jun 4 23:51:08.976339 kernel: audit: type=1130 audit(1780617068.958: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' Jun 4 23:51:08.958000 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' Jun 4 23:51:09.008623 systemd[1]: Finished dracut ask for additional cmdline parameters. Jun 4 23:51:09.036660 kernel: audit: type=1130 audit(1780617069.008: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' Jun 4 23:51:09.008000 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' Jun 4 23:51:09.036814 systemd[1]: Starting dracut cmdline hook... Jun 4 23:51:09.063621 dracut-cmdline[208]: dracut-dracut-053 Jun 4 23:51:09.072890 dracut-cmdline[208]: 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 Jun 4 23:51:09.255589 kernel: SCSI subsystem initialized Jun 4 23:51:09.269689 kernel: Loading iSCSI transport class v2.0-870. Jun 4 23:51:09.286890 kernel: iscsi: registered transport (tcp) Jun 4 23:51:09.316222 kernel: iscsi: registered transport (qla4xxx) Jun 4 23:51:09.316568 kernel: QLogic iSCSI HBA Driver Jun 4 23:51:09.330028 systemd[1]: Finished dracut cmdline hook. Jun 4 23:51:09.336000 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' Jun 4 23:51:09.339048 systemd[1]: Starting dracut pre-udev hook... Jun 4 23:51:09.357913 kernel: audit: type=1130 audit(1780617069.336: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' Jun 4 23:51:09.378899 kernel: device-mapper: uevent: version 1.0.3 Jun 4 23:51:09.379060 kernel: device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com Jun 4 23:51:09.439679 kernel: raid6: avx512x4 gen() 38745 MB/s Jun 4 23:51:09.460025 kernel: raid6: avx512x4 xor() 8787 MB/s Jun 4 23:51:09.480658 kernel: raid6: avx512x2 gen() 28552 MB/s Jun 4 23:51:09.501630 kernel: raid6: avx512x2 xor() 17615 MB/s Jun 4 23:51:09.521634 kernel: raid6: avx512x1 gen() 25089 MB/s Jun 4 23:51:09.541630 kernel: raid6: avx512x1 xor() 23050 MB/s Jun 4 23:51:09.561624 kernel: raid6: avx2x4 gen() 32176 MB/s Jun 4 23:51:09.581646 kernel: raid6: avx2x4 xor() 6985 MB/s Jun 4 23:51:09.601659 kernel: raid6: avx2x2 gen() 27323 MB/s Jun 4 23:51:09.621675 kernel: raid6: avx2x2 xor() 19905 MB/s Jun 4 23:51:09.642761 kernel: raid6: avx2x1 gen() 19187 MB/s Jun 4 23:51:09.662642 kernel: raid6: avx2x1 xor() 6891 MB/s Jun 4 23:51:09.683722 kernel: raid6: sse2x4 gen() 10148 MB/s Jun 4 23:51:09.722807 kernel: raid6: sse2x4 xor() 4171 MB/s Jun 4 23:51:09.742590 kernel: raid6: sse2x2 gen() 9789 MB/s Jun 4 23:51:09.762637 kernel: raid6: sse2x2 xor() 6598 MB/s Jun 4 23:51:09.782671 kernel: raid6: sse2x1 gen() 7696 MB/s Jun 4 23:51:09.805882 kernel: raid6: sse2x1 xor() 5184 MB/s Jun 4 23:51:09.806158 kernel: raid6: using algorithm avx512x4 gen() 38745 MB/s Jun 4 23:51:09.806167 kernel: raid6: .... xor() 8787 MB/s, rmw enabled Jun 4 23:51:09.809975 kernel: raid6: using avx512x2 recovery algorithm Jun 4 23:51:09.837594 kernel: xor: automatically using best checksumming function avx Jun 4 23:51:09.980588 kernel: Btrfs loaded, crc32c=crc32c-intel Jun 4 23:51:09.992367 systemd[1]: Finished dracut pre-udev hook. Jun 4 23:51:10.018645 kernel: audit: type=1130 audit(1780617069.995: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' Jun 4 23:51:10.018713 kernel: audit: type=1334 audit(1780617070.018:10): prog-id=6 op=LOAD Jun 4 23:51:09.995000 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' Jun 4 23:51:10.018000 audit: BPF prog-id=6 op=LOAD Jun 4 23:51:10.023000 audit: BPF prog-id=7 op=LOAD Jun 4 23:51:10.030025 kernel: audit: type=1334 audit(1780617070.023:11): prog-id=7 op=LOAD Jun 4 23:51:10.029000 audit: BPF prog-id=8 op=LOAD Jun 4 23:51:10.031284 systemd[1]: Starting Rule-based Manager for Device Events and Files... Jun 4 23:51:10.061911 systemd-udevd[329]: /usr/lib64/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Jun 4 23:51:10.064766 systemd[1]: Started Rule-based Manager for Device Events and Files. Jun 4 23:51:10.084000 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' Jun 4 23:51:10.091912 systemd[1]: Starting dracut pre-trigger hook... Jun 4 23:51:10.101000 audit: BPF prog-id=9 op=LOAD Jun 4 23:51:10.106867 systemd[1]: Starting Network Configuration... Jun 4 23:51:10.156138 dracut-pre-trigger[340]: rd.md=0: removing MD RAID activation Jun 4 23:51:10.162163 systemd-networkd[341]: lo: Link UP Jun 4 23:51:10.162193 systemd-networkd[341]: lo: Gained carrier Jun 4 23:51:10.165000 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' Jun 4 23:51:10.171000 audit: BPF prog-id=10 op=LOAD Jun 4 23:51:10.163304 systemd-networkd[341]: Enumeration completed Jun 4 23:51:10.163623 systemd[1]: Started Network Configuration. Jun 4 23:51:10.172659 systemd[1]: Starting Network Name Resolution... Jun 4 23:51:10.215694 systemd[1]: Finished dracut pre-trigger hook. Jun 4 23:51:10.215000 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' Jun 4 23:51:10.222723 systemd[1]: Starting Coldplug All udev Devices... Jun 4 23:51:10.231225 systemd-resolved[353]: Positive Trust Anchors: Jun 4 23:51:10.231267 systemd-resolved[353]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 4 23:51:10.231290 systemd-resolved[353]: 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 Jun 4 23:51:10.243000 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' Jun 4 23:51:10.231588 systemd-resolved[353]: Defaulting to hostname 'linux'. Jun 4 23:51:10.233302 systemd[1]: Started Network Name Resolution. Jun 4 23:51:10.243829 systemd[1]: Reached target Network. Jun 4 23:51:10.267668 systemd[1]: Reached target Host and Network Name Lookups. Jun 4 23:51:10.275276 systemd[1]: Starting iSCSI UserSpace I/O driver... Jun 4 23:51:10.288000 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' Jun 4 23:51:10.283290 systemd[1]: Started iSCSI UserSpace I/O driver. Jun 4 23:51:10.298645 iscsid[375]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Jun 4 23:51:10.298645 iscsid[375]: 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 Jun 4 23:51:10.298645 iscsid[375]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Jun 4 23:51:10.298645 iscsid[375]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Jun 4 23:51:10.298645 iscsid[375]: If using hardware iscsi like qla4xxx this message can be ignored. Jun 4 23:51:10.298645 iscsid[375]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Jun 4 23:51:10.298645 iscsid[375]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Jun 4 23:51:10.301000 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' Jun 4 23:51:10.290627 systemd[1]: Starting Open-iSCSI... Jun 4 23:51:10.298551 systemd[1]: Started Open-iSCSI. Jun 4 23:51:10.360160 systemd-udevd[329]: /usr/lib64/udev/rules.d/50-udev-default.rules:42 Unknown group 'sgx', ignoring Jun 4 23:51:10.397259 systemd[1]: Finished Coldplug All udev Devices. Jun 4 23:51:10.396000 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' Jun 4 23:51:10.405989 systemd[1]: Starting dracut initqueue hook... Jun 4 23:51:10.845975 kernel: cryptd: max_cpu_qlen set to 1000 Jun 4 23:51:10.882633 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jun 4 23:51:10.882771 kernel: libata version 3.00 loaded. Jun 4 23:51:10.882781 kernel: vda: detected capacity change from 0 to 4756340736 Jun 4 23:51:10.900573 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 4 23:51:10.909931 systemd-udevd[389]: Using default interface naming scheme 'v249'. Jun 4 23:51:10.917342 kernel: AVX2 version of gcm_enc/dec engaged. Jun 4 23:51:10.917367 kernel: AES CTR mode by8 optimization enabled Jun 4 23:51:10.918595 kernel: ahci 0000:00:1f.2: version 3.0 Jun 4 23:51:10.920569 kernel: PCI Interrupt Link [GSIA] enabled at IRQ 16 Jun 4 23:51:10.926616 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Jun 4 23:51:10.926743 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jun 4 23:51:10.947950 systemd-networkd[341]: eth0: Link UP Jun 4 23:51:11.369370 kernel: scsi host0: ahci Jun 4 23:51:11.370797 kernel: scsi host1: ahci Jun 4 23:51:11.370960 kernel: scsi host2: ahci Jun 4 23:51:11.371045 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by systemd-udevd (382) Jun 4 23:51:11.371056 kernel: scsi host3: ahci Jun 4 23:51:11.371241 kernel: scsi host4: ahci Jun 4 23:51:11.371368 kernel: scsi host5: ahci Jun 4 23:51:11.371573 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 Jun 4 23:51:11.371585 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 Jun 4 23:51:11.371600 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 Jun 4 23:51:11.371611 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 Jun 4 23:51:11.371620 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 Jun 4 23:51:11.371630 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 Jun 4 23:51:11.371640 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jun 4 23:51:11.371650 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jun 4 23:51:11.371660 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jun 4 23:51:10.969674 systemd[1]: Found device /dev/disk/by-label/EFI-SYSTEM. Jun 4 23:51:11.392663 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jun 4 23:51:11.393336 kernel: ata3.00: applying bridge limits Jun 4 23:51:11.393353 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jun 4 23:51:11.389088 systemd[1]: Found device /dev/disk/by-partlabel/USR-A. Jun 4 23:51:11.395809 systemd[1]: Found device /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jun 4 23:51:11.426028 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jun 4 23:51:11.426054 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jun 4 23:51:11.426063 kernel: ata3.00: configured for UDMA/100 Jun 4 23:51:11.426073 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jun 4 23:51:11.402758 systemd[1]: Found device /dev/disk/by-label/ROOT. Jun 4 23:51:11.432989 systemd[1]: Found device /dev/disk/by-label/OEM. Jun 4 23:51:11.433205 systemd[1]: Reached target Initrd Root Device. Jun 4 23:51:11.446343 systemd[1]: Starting Generate new UUID for disk GPT if necessary... Jun 4 23:51:11.467572 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 4 23:51:11.493560 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jun 4 23:51:11.493850 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jun 4 23:51:11.533544 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jun 4 23:51:11.908709 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Jun 4 23:51:11.908850 systemd-networkd[341]: eth0: Gained carrier Jun 4 23:51:11.916672 systemd-networkd[341]: eth0: DHCPv4 address 10.0.0.3/16 via 10.0.0.1 Jun 4 23:51:12.026743 systemd[1]: Finished dracut initqueue hook. Jun 4 23:51:12.026000 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' Jun 4 23:51:12.027138 systemd[1]: Reached target Preparation for Remote File Systems. Jun 4 23:51:12.032063 systemd[1]: Reached target Remote Encrypted Volumes. Jun 4 23:51:12.038730 systemd[1]: Reached target Remote File Systems. Jun 4 23:51:12.050163 systemd[1]: Starting dracut pre-mount hook... Jun 4 23:51:12.062989 systemd[1]: Finished dracut pre-mount hook. Jun 4 23:51:12.062000 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' Jun 4 23:51:12.481612 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 4 23:51:12.483095 disk-uuid[469]: The operation has completed successfully. Jun 4 23:51:12.514651 systemd[1]: disk-uuid.service: Deactivated successfully. Jun 4 23:51:12.519000 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' Jun 4 23:51:12.519000 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' Jun 4 23:51:12.514906 systemd[1]: Finished Generate new UUID for disk GPT if necessary. Jun 4 23:51:12.520372 systemd[1]: Starting Ignition (setup)... Jun 4 23:51:12.546731 kernel: BTRFS info (device vda6): disk space caching is enabled Jun 4 23:51:12.546906 kernel: BTRFS info (device vda6): has skinny extents Jun 4 23:51:12.569261 systemd[1]: mnt-oem.mount: Deactivated successfully. Jun 4 23:51:12.583814 systemd[1]: ignition-setup.service: Deactivated successfully. Jun 4 23:51:12.589000 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' Jun 4 23:51:12.589000 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' Jun 4 23:51:12.584178 systemd[1]: Finished Ignition (setup). Jun 4 23:51:12.591778 systemd[1]: Starting Ignition (disks)... Jun 4 23:51:12.653027 ignition[511]: Ignition v0.36.1-15-gde4e6cc9 Jun 4 23:51:12.653090 ignition[511]: Stage: disks Jun 4 23:51:12.653125 ignition[511]: reading system config file "/usr/lib/ignition/base.ign" Jun 4 23:51:12.653203 ignition[511]: no config at "/usr/lib/ignition/base.ign" Jun 4 23:51:12.653308 ignition[511]: parsed url from cmdline: "" Jun 4 23:51:12.653311 ignition[511]: no config URL provided Jun 4 23:51:12.653314 ignition[511]: reading system config file "/usr/lib/ignition/user.ign" Jun 4 23:51:12.653321 ignition[511]: no config at "/usr/lib/ignition/user.ign" Jun 4 23:51:12.653340 ignition[511]: op(1): [started] loading QEMU firmware config module Jun 4 23:51:12.653344 ignition[511]: op(1): executing: "modprobe" "qemu_fw_cfg" Jun 4 23:51:12.655655 ignition[511]: op(1): [finished] loading QEMU firmware config module Jun 4 23:51:12.789197 ignition[511]: parsing config with SHA512: fb66565fb2465bf5059eaa232490597aeb0ef70ee45fdc9b8492ad8325cb04ad355e2fe5c41acbeac8d2afdc5f45d0d06ba2106c620f4371af156deee8b2ae77 Jun 4 23:51:12.791946 ignition[511]: disks: disks passed Jun 4 23:51:12.798000 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' Jun 4 23:51:12.798000 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' Jun 4 23:51:12.791982 ignition[511]: Ignition finished successfully Jun 4 23:51:12.792852 systemd[1]: ignition-disks.service: Deactivated successfully. Jun 4 23:51:12.792999 systemd[1]: Finished Ignition (disks). Jun 4 23:51:12.798826 systemd[1]: Reached target Preparation for Local File Systems. Jun 4 23:51:12.828352 systemd-fsck[524]: ROOT: clean, 556/553792 files, 37783/553472 blocks Jun 4 23:51:12.843605 kernel: device-mapper: verity: sha256 using implementation "sha256-generic" Jun 4 23:51:12.806286 systemd[1]: Starting File System Check on /dev/disk/by-label/ROOT... Jun 4 23:51:12.843000 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' Jun 4 23:51:12.809083 systemd[1]: Starting Verity Setup for /dev/mapper/usr... Jun 4 23:51:12.828725 systemd[1]: Finished File System Check on /dev/disk/by-label/ROOT. Jun 4 23:51:12.845360 systemd[1]: Mounting /sysroot... Jun 4 23:51:12.885586 systemd[1]: Found device /dev/mapper/usr. Jun 4 23:51:12.895000 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' Jun 4 23:51:12.886959 systemd[1]: Starting File System Check on /dev/mapper/usr... Jun 4 23:51:12.892416 systemd[1]: Finished Verity Setup for /dev/mapper/usr. Jun 4 23:51:12.920960 systemd-fsck[538]: fsck.ext4: Operation not permitted while trying to open /dev/mapper/usr Jun 4 23:51:12.920960 systemd-fsck[538]: You must have r/w access to the filesystem or be root Jun 4 23:51:12.930379 systemd-fsck[535]: fsck failed with exit status 8. Jun 4 23:51:12.935000 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' Jun 4 23:51:12.931314 systemd-fsck[535]: Ignoring error. Jun 4 23:51:12.934217 systemd[1]: Finished File System Check on /dev/mapper/usr. Jun 4 23:51:12.939881 systemd[1]: Mounting /sysusr/usr... Jun 4 23:51:12.982687 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null) Jun 4 23:51:12.982936 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: (null) Jun 4 23:51:12.989610 kernel: ext4 filesystem being mounted at /sysroot supports timestamps until 2038 (0x7fffffff) Jun 4 23:51:12.990074 systemd[1]: Mounted /sysusr/usr. Jun 4 23:51:12.997097 systemd[1]: Reached target Local File Systems. Jun 4 23:51:13.005310 systemd[1]: Reached target System Initialization. Jun 4 23:51:13.005378 systemd[1]: Reached target Basic System. Jun 4 23:51:13.023153 systemd[1]: Mounted /sysroot. Jun 4 23:51:13.023397 systemd[1]: Reached target Initrd Root File System. Jun 4 23:51:13.033057 systemd[1]: Mounting /sysroot/usr... Jun 4 23:51:13.037556 systemd[1]: Mounted /sysroot/usr. Jun 4 23:51:13.045047 systemd[1]: Starting Root filesystem setup... Jun 4 23:51:13.122579 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jun 4 23:51:13.122760 systemd[1]: Finished Root filesystem setup. Jun 4 23:51:13.130000 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' Jun 4 23:51:13.130000 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' Jun 4 23:51:13.134561 systemd[1]: Starting Ignition (files)... Jun 4 23:51:13.138734 systemd[1]: Starting /sysroot/boot... Jun 4 23:51:13.508008 systemd-networkd[341]: eth0: Gained IPv6LL Jun 4 23:51:13.945540 ignition[554]: Ignition v0.36.1-15-gde4e6cc9 Jun 4 23:51:13.945578 ignition[554]: Stage: files Jun 4 23:51:13.949361 systemd[1]: Finished /sysroot/boot. Jun 4 23:51:13.945586 ignition[554]: reading system config file "/usr/lib/ignition/base.ign" Jun 4 23:51:13.945622 ignition[554]: no config at "/usr/lib/ignition/base.ign" Jun 4 23:51:13.946059 ignition[554]: files: compiled without relabeling support, skipping Jun 4 23:51:13.979956 kernel: kauditd_printk_skb: 23 callbacks suppressed Jun 4 23:51:13.980099 kernel: audit: type=1130 audit(1780617073.967:35): 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' Jun 4 23:51:13.967000 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' Jun 4 23:51:14.012778 ignition[554]: files: createUsers: op(1): [started] creating or modifying user "core" Jun 4 23:51:14.012835 ignition[554]: files: createUsers: op(1): executing: "/usr/sbin/usermod" "--root" "/sysroot" "core" Jun 4 23:51:14.018354 ignition[554]: files: createUsers: op(1): [finished] creating or modifying user "core" Jun 4 23:51:14.018388 ignition[554]: files: createUsers: op(2): [started] adding ssh keys to user "core" Jun 4 23:51:14.026357 ignition[554]: files: createUsers: op(2): [finished] adding ssh keys to user "core" Jun 4 23:51:14.026375 ignition[554]: files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/etc/flatcar/update.conf" Jun 4 23:51:14.073155 kernel: audit: type=1130 audit(1780617074.037:36): 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' Jun 4 23:51:14.073188 kernel: audit: type=1131 audit(1780617074.037:37): 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' Jun 4 23:51:14.037000 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' Jun 4 23:51:14.037000 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' Jun 4 23:51:14.030900 systemd[1]: ignition-files.service: Deactivated successfully. Jun 4 23:51:14.029038 ignition[554]: files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/etc/flatcar/update.conf" Jun 4 23:51:14.031039 systemd[1]: Finished Ignition (files). Jun 4 23:51:14.029049 ignition[554]: files: op(4): [started] processing unit "coreos-metadata.service" Jun 4 23:51:14.141051 kernel: audit: type=1130 audit(1780617074.100:38): 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' Jun 4 23:51:14.141089 kernel: audit: type=1131 audit(1780617074.100:39): 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' Jun 4 23:51:14.100000 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' Jun 4 23:51:14.100000 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' Jun 4 23:51:14.038333 systemd[1]: Condition check resulted in Populate torcx store to satisfy profile being skipped. Jun 4 23:51:14.029191 ignition[554]: files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Jun 4 23:51:14.039951 systemd[1]: Starting Ignition (record completion)... Jun 4 23:51:14.029898 ignition[554]: files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "etc/systemd/system/coreos-metadata.service" Jun 4 23:51:14.091040 systemd[1]: Starting Reload Configuration from the Real Root... Jun 4 23:51:14.029905 ignition[554]: files: op(4): [finished] processing unit "coreos-metadata.service" Jun 4 23:51:14.091591 systemd[1]: ignition-quench.service: Deactivated successfully. Jun 4 23:51:14.029911 ignition[554]: files: files passed Jun 4 23:51:14.091888 systemd[1]: Finished Ignition (record completion). Jun 4 23:51:14.029916 ignition[554]: Ignition finished successfully Jun 4 23:51:14.206700 systemd[1]: Reloading. Jun 4 23:51:14.217000 audit: BPF prog-id=9 op=UNLOAD Jun 4 23:51:14.219000 audit: BPF prog-id=10 op=UNLOAD Jun 4 23:51:14.230950 kernel: audit: type=1334 audit(1780617074.217:40): prog-id=9 op=UNLOAD Jun 4 23:51:14.231003 kernel: audit: type=1334 audit(1780617074.219:41): prog-id=10 op=UNLOAD Jun 4 23:51:14.231016 kernel: audit: type=1334 audit(1780617074.220:42): prog-id=3 op=UNLOAD Jun 4 23:51:14.220000 audit: BPF prog-id=3 op=UNLOAD Jun 4 23:51:14.237066 kernel: audit: type=1334 audit(1780617074.224:43): prog-id=6 op=UNLOAD Jun 4 23:51:14.224000 audit: BPF prog-id=6 op=UNLOAD Jun 4 23:51:14.405000 audit: BPF prog-id=11 op=LOAD Jun 4 23:51:14.411000 audit: BPF prog-id=12 op=LOAD Jun 4 23:51:14.412587 kernel: audit: type=1334 audit(1780617074.405:44): prog-id=11 op=LOAD Jun 4 23:51:14.413000 audit: BPF prog-id=13 op=LOAD Jun 4 23:51:14.413000 audit: BPF prog-id=14 op=LOAD Jun 4 23:51:14.414000 audit: BPF prog-id=15 op=LOAD Jun 4 23:51:14.414000 audit: BPF prog-id=4 op=UNLOAD Jun 4 23:51:14.414000 audit: BPF prog-id=5 op=UNLOAD Jun 4 23:51:14.416000 audit: BPF prog-id=16 op=LOAD Jun 4 23:51:14.416000 audit: BPF prog-id=17 op=LOAD Jun 4 23:51:14.417000 audit: BPF prog-id=18 op=LOAD Jun 4 23:51:14.417000 audit: BPF prog-id=7 op=UNLOAD Jun 4 23:51:14.417000 audit: BPF prog-id=8 op=UNLOAD Jun 4 23:51:14.442251 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jun 4 23:51:14.442693 systemd[1]: Finished Reload Configuration from the Real Root. Jun 4 23:51:14.445000 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' Jun 4 23:51:14.445000 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' Jun 4 23:51:14.445964 systemd[1]: Reached target Initrd File Systems. Jun 4 23:51:14.460397 systemd[1]: Reached target Initrd Default Target. Jun 4 23:51:14.464782 systemd[1]: Condition check resulted in dracut mount hook being skipped. Jun 4 23:51:14.467680 systemd[1]: Starting dracut pre-pivot and cleanup hook... Jun 4 23:51:14.546315 systemd[1]: Finished dracut pre-pivot and cleanup hook. Jun 4 23:51:14.546000 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' Jun 4 23:51:14.555686 systemd[1]: Starting Cleaning Up and Shutting Down Daemons... Jun 4 23:51:14.575122 systemd[1]: Stopped target Host and Network Name Lookups. Jun 4 23:51:14.583265 systemd[1]: Stopped target Remote Encrypted Volumes. Jun 4 23:51:14.589984 systemd[1]: Stopped target Timer Units. Jun 4 23:51:14.595923 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jun 4 23:51:14.596169 systemd[1]: Stopped dracut pre-pivot and cleanup hook. Jun 4 23:51:14.603000 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' Jun 4 23:51:14.605368 systemd[1]: Stopped target Initrd Default Target. Jun 4 23:51:14.610167 systemd[1]: Stopped target Basic System. Jun 4 23:51:14.613009 systemd[1]: Stopped target Initrd Root Device. Jun 4 23:51:14.616457 systemd[1]: Stopped target Path Units. Jun 4 23:51:14.622197 systemd[1]: Stopped target Remote File Systems. Jun 4 23:51:14.631698 systemd[1]: Stopped target Preparation for Remote File Systems. Jun 4 23:51:14.634373 systemd[1]: Stopped target Slice Units. Jun 4 23:51:14.643863 systemd[1]: Stopped target Socket Units. Jun 4 23:51:14.646076 systemd[1]: Stopped target System Initialization. Jun 4 23:51:14.655575 systemd[1]: Stopped target Local File Systems. Jun 4 23:51:14.657600 systemd[1]: Stopped target Preparation for Local File Systems. Jun 4 23:51:14.665752 systemd[1]: Stopped target Swaps. Jun 4 23:51:14.674631 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jun 4 23:51:14.674924 systemd[1]: Stopped dracut pre-mount hook. Jun 4 23:51:14.681000 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' Jun 4 23:51:14.682170 systemd[1]: Stopped target Local Encrypted Volumes. Jun 4 23:51:14.688206 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jun 4 23:51:14.689967 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. Jun 4 23:51:14.697000 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' Jun 4 23:51:14.703953 iscsid[375]: iscsid shutting down. Jun 4 23:51:14.694986 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jun 4 23:51:14.695145 systemd[1]: Stopped dracut initqueue hook. Jun 4 23:51:14.712000 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' Jun 4 23:51:14.698754 systemd[1]: Stopping Open-iSCSI... Jun 4 23:51:14.722000 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' Jun 4 23:51:14.707727 systemd[1]: Stopping /sysroot/boot... Jun 4 23:51:14.724000 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' Jun 4 23:51:14.708350 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jun 4 23:51:14.708527 systemd[1]: Stopped Coldplug All udev Devices. Jun 4 23:51:14.713603 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jun 4 23:51:14.713706 systemd[1]: Stopped dracut pre-trigger hook. Jun 4 23:51:14.724158 systemd[1]: iscsid.service: Deactivated successfully. Jun 4 23:51:14.749000 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' Jun 4 23:51:14.724593 systemd[1]: Stopped Open-iSCSI. Jun 4 23:51:14.760000 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' Jun 4 23:51:14.725794 systemd[1]: iscsid.socket: Deactivated successfully. Jun 4 23:51:14.725864 systemd[1]: Closed Open-iSCSI iscsid Socket. Jun 4 23:51:14.733072 systemd[1]: Stopping iSCSI UserSpace I/O driver... Jun 4 23:51:14.742843 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jun 4 23:51:14.743360 systemd[1]: iscsiuio.service: Deactivated successfully. Jun 4 23:51:14.794000 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' Jun 4 23:51:14.743648 systemd[1]: Stopped iSCSI UserSpace I/O driver. Jun 4 23:51:14.750985 systemd[1]: sysroot-boot.service: Deactivated successfully. Jun 4 23:51:14.751241 systemd[1]: Stopped /sysroot/boot. Jun 4 23:51:14.810000 audit: BPF prog-id=12 op=UNLOAD Jun 4 23:51:14.761378 systemd[1]: Stopped target Network. Jun 4 23:51:14.766827 systemd[1]: iscsiuio.socket: Deactivated successfully. Jun 4 23:51:14.766929 systemd[1]: Closed Open-iSCSI iscsiuio Socket. Jun 4 23:51:14.819000 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' Jun 4 23:51:14.819000 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' Jun 4 23:51:14.775330 systemd[1]: Stopping Network Name Resolution... Jun 4 23:51:14.786111 systemd[1]: systemd-resolved.service: Deactivated successfully. Jun 4 23:51:14.831000 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' Jun 4 23:51:14.786289 systemd[1]: Stopped Network Name Resolution. Jun 4 23:51:14.798112 systemd[1]: Stopping Network Configuration... Jun 4 23:51:14.845000 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' Jun 4 23:51:14.803880 systemd-networkd[341]: eth0: DHCP lease lost Jun 4 23:51:14.817037 systemd-networkd[341]: eth0: DHCPv6 lease lost Jun 4 23:51:14.853000 audit: BPF prog-id=11 op=UNLOAD Jun 4 23:51:14.818299 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jun 4 23:51:14.866000 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' Jun 4 23:51:14.818529 systemd[1]: Finished Cleaning Up and Shutting Down Daemons. Jun 4 23:51:14.826603 systemd[1]: systemd-networkd.service: Deactivated successfully. Jun 4 23:51:14.829074 systemd[1]: Stopped Network Configuration. Jun 4 23:51:14.832233 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jun 4 23:51:14.888000 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' Jun 4 23:51:14.832269 systemd[1]: Closed Network Service Netlink Socket. Jun 4 23:51:14.895000 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' Jun 4 23:51:14.842995 systemd[1]: Stopping Network Cleanup... Jun 4 23:51:14.902000 audit: BPF prog-id=16 op=UNLOAD Jun 4 23:51:14.902000 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' Jun 4 23:51:14.843717 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jun 4 23:51:14.843773 systemd[1]: Stopped Apply Kernel Variables. Jun 4 23:51:14.846092 systemd[1]: Stopping Rule-based Manager for Device Events and Files... Jun 4 23:51:14.918000 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' Jun 4 23:51:14.857726 systemd[1]: systemd-udevd.service: Deactivated successfully. Jun 4 23:51:14.921000 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' Jun 4 23:51:14.857863 systemd[1]: Stopped Rule-based Manager for Device Events and Files. Jun 4 23:51:14.935000 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' Jun 4 23:51:14.873029 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jun 4 23:51:14.942000 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' Jun 4 23:51:14.873083 systemd[1]: Closed udev Control Socket. Jun 4 23:51:14.949000 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' Jun 4 23:51:14.949000 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' Jun 4 23:51:14.880022 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jun 4 23:51:14.880069 systemd[1]: Closed udev Kernel Socket. Jun 4 23:51:14.880243 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jun 4 23:51:14.880286 systemd[1]: Stopped dracut pre-udev hook. Jun 4 23:51:14.889009 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jun 4 23:51:14.968000 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' Jun 4 23:51:14.889052 systemd[1]: Stopped dracut cmdline hook. Jun 4 23:51:14.895776 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jun 4 23:51:14.895818 systemd[1]: Stopped dracut ask for additional cmdline parameters. Jun 4 23:51:14.906655 systemd[1]: Starting Cleanup udev Database... Jun 4 23:51:14.909633 systemd[1]: Stopping Hardware RNG Entropy Gatherer Daemon... Jun 4 23:51:14.911316 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jun 4 23:51:14.911364 systemd[1]: Stopped Create Static Device Nodes in /dev. Jun 4 23:51:14.919028 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jun 4 23:51:14.919192 systemd[1]: Stopped Create List of Static Device Nodes. Jun 4 23:51:14.922341 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 4 23:51:14.922380 systemd[1]: Stopped Setup Virtual Console. Jun 4 23:51:14.936808 systemd[1]: rngd.service: Deactivated successfully. Jun 4 23:51:14.936987 systemd[1]: Stopped Hardware RNG Entropy Gatherer Daemon. Jun 4 23:51:14.943352 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jun 4 23:51:14.943610 systemd[1]: Finished Cleanup udev Database. Jun 4 23:51:14.966878 systemd[1]: network-cleanup.service: Deactivated successfully. Jun 4 23:51:14.967088 systemd[1]: Stopped Network Cleanup. Jun 4 23:51:14.968986 systemd[1]: Reached target Switch Root. Jun 4 23:51:14.991754 systemd[1]: Starting Switch Root... Jun 4 23:51:15.107711 systemd[1]: Switching root. Jun 4 23:51:15.108000 audit: BPF prog-id=13 op=UNLOAD Jun 4 23:51:15.136255 systemd-journald[191]: Journal stopped Jun 4 23:51:36.716691 systemd-journald[191]: Received SIGTERM from PID 1 (systemd). Jun 4 23:51:36.716739 kernel: SELinux: policy capability network_peer_controls=1 Jun 4 23:51:36.716749 kernel: SELinux: policy capability open_perms=1 Jun 4 23:51:36.716757 kernel: SELinux: policy capability extended_socket_class=1 Jun 4 23:51:36.716766 kernel: SELinux: policy capability always_check_network=0 Jun 4 23:51:36.716774 kernel: SELinux: policy capability cgroup_seclabel=1 Jun 4 23:51:36.716784 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jun 4 23:51:36.716793 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jun 4 23:51:36.716801 systemd[1]: Successfully loaded SELinux policy in 205.089ms. Jun 4 23:51:36.716814 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 18.464ms. Jun 4 23:51:36.716822 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) Jun 4 23:51:36.716831 systemd[1]: Detected virtualization kvm. Jun 4 23:51:36.716838 systemd[1]: Detected architecture x86-64. Jun 4 23:51:36.716846 systemd[1]: Detected first boot. Jun 4 23:51:36.716855 systemd[1]: Initializing machine ID from VM UUID. Jun 4 23:51:36.716863 systemd[1]: Populated /etc with preset unit settings. Jun 4 23:51:36.716875 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. Jun 4 23:51:36.716884 systemd[1]: initrd-switch-root.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jun 4 23:51:36.716892 kernel: kauditd_printk_skb: 50 callbacks suppressed Jun 4 23:51:36.716937 kernel: audit: type=1334 audit(1780617095.603:95): prog-id=21 op=LOAD Jun 4 23:51:36.716944 kernel: audit: type=1334 audit(1780617095.614:96): prog-id=22 op=LOAD Jun 4 23:51:36.716953 kernel: audit: type=1334 audit(1780617095.621:97): prog-id=23 op=LOAD Jun 4 23:51:36.716959 kernel: audit: type=1334 audit(1780617095.621:98): prog-id=14 op=UNLOAD Jun 4 23:51:36.716966 kernel: audit: type=1334 audit(1780617095.621:99): prog-id=15 op=UNLOAD Jun 4 23:51:36.716973 kernel: audit: type=1334 audit(1780617095.728:100): prog-id=24 op=LOAD Jun 4 23:51:36.716980 kernel: audit: type=1334 audit(1780617095.730:101): prog-id=21 op=UNLOAD Jun 4 23:51:36.716987 kernel: audit: type=1334 audit(1780617095.737:102): prog-id=25 op=LOAD Jun 4 23:51:36.716993 kernel: audit: type=1334 audit(1780617095.744:103): prog-id=26 op=LOAD Jun 4 23:51:36.717000 kernel: audit: type=1334 audit(1780617095.745:104): prog-id=22 op=UNLOAD Jun 4 23:51:36.717007 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jun 4 23:51:36.717015 systemd[1]: Stopped Switch Root. Jun 4 23:51:36.717024 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jun 4 23:51:36.717032 systemd[1]: Created slice Slice /system/addon-config. Jun 4 23:51:36.717039 systemd[1]: Created slice Slice /system/addon-run. Jun 4 23:51:36.717046 systemd[1]: Created slice Slice /system/getty. Jun 4 23:51:36.717053 systemd[1]: Created slice Slice /system/modprobe. Jun 4 23:51:36.717060 systemd[1]: Created slice Slice /system/serial-getty. Jun 4 23:51:36.717067 systemd[1]: Created slice Slice /system/system-cloudinit. Jun 4 23:51:36.717074 systemd[1]: Created slice Slice /system/systemd-fsck. Jun 4 23:51:36.717081 systemd[1]: Created slice User and Session Slice. Jun 4 23:51:36.717120 systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Jun 4 23:51:36.717128 systemd[1]: Started Forward Password Requests to Wall Directory Watch. Jun 4 23:51:36.717135 systemd[1]: Set up automount Boot partition Automount Point. Jun 4 23:51:36.717143 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Jun 4 23:51:36.717150 systemd[1]: Stopped target Switch Root. Jun 4 23:51:36.717157 systemd[1]: Stopped target Initrd File Systems. Jun 4 23:51:36.717164 systemd[1]: Stopped target Initrd Root File System. Jun 4 23:51:36.717172 systemd[1]: Reached target Remote Encrypted Volumes. Jun 4 23:51:36.717180 systemd[1]: Reached target Remote File Systems. Jun 4 23:51:36.717188 systemd[1]: Reached target Slice Units. Jun 4 23:51:36.717195 systemd[1]: Reached target Swaps. Jun 4 23:51:36.717202 systemd[1]: Reached target Verify torcx succeeded. Jun 4 23:51:36.717209 systemd[1]: Reached target Local Verity Protected Volumes. Jun 4 23:51:36.717217 systemd[1]: Listening on Process Core Dump Socket. Jun 4 23:51:36.717224 systemd[1]: Listening on initctl Compatibility Named Pipe. Jun 4 23:51:36.717231 systemd[1]: Listening on Network Service Netlink Socket. Jun 4 23:51:36.717238 systemd[1]: Listening on udev Control Socket. Jun 4 23:51:36.717245 systemd[1]: Listening on udev Kernel Socket. Jun 4 23:51:36.717252 systemd[1]: Mounting Huge Pages File System... Jun 4 23:51:36.717260 systemd[1]: Mounting POSIX Message Queue File System... Jun 4 23:51:36.717267 systemd[1]: Mounting External Media Directory... Jun 4 23:51:36.717304 systemd[1]: Condition check resulted in /proc/xen being skipped. Jun 4 23:51:36.717312 systemd[1]: Mounting Kernel Debug File System... Jun 4 23:51:36.717319 systemd[1]: Mounting Kernel Trace File System... Jun 4 23:51:36.717326 systemd[1]: Mounting Temporary Directory /tmp... Jun 4 23:51:36.717333 systemd[1]: Starting Create missing system files... Jun 4 23:51:36.717340 systemd[1]: Starting Create List of Static Device Nodes... Jun 4 23:51:36.717347 systemd[1]: Starting Load Kernel Module configfs... Jun 4 23:51:36.717354 systemd[1]: Starting Load Kernel Module drm... Jun 4 23:51:36.717363 systemd[1]: Starting Load Kernel Module fuse... Jun 4 23:51:36.717370 systemd[1]: Condition check resulted in Create /etc/nsswitch.conf being skipped. Jun 4 23:51:36.717377 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jun 4 23:51:36.717384 kernel: fuse: init (API version 7.32) Jun 4 23:51:36.717392 systemd[1]: Stopped File System Check on Root Device. Jun 4 23:51:36.717399 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jun 4 23:51:36.717406 systemd[1]: Stopped systemd-fsck-usr.service. Jun 4 23:51:36.717413 systemd[1]: Stopped Journal Service. Jun 4 23:51:36.717422 systemd[1]: Starting Journal Service... Jun 4 23:51:36.717431 systemd[1]: Condition check resulted in Load Kernel Modules being skipped. Jun 4 23:51:36.717438 systemd[1]: Starting Remount Root and Kernel File Systems... Jun 4 23:51:36.717448 systemd-journald[774]: Journal started Jun 4 23:51:36.717596 systemd-journald[774]: Runtime Journal (/run/log/journal/477609d1e66a4eed9ba14c01cdbaa162) is 6.0M, max 48.7M, 42.6M free. Jun 4 23:51:15.493000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Jun 4 23:51:15.638000 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 Jun 4 23:51:15.638000 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 Jun 4 23:51:15.638000 audit: BPF prog-id=19 op=LOAD Jun 4 23:51:15.638000 audit: BPF prog-id=19 op=UNLOAD Jun 4 23:51:15.638000 audit: BPF prog-id=20 op=LOAD Jun 4 23:51:15.638000 audit: BPF prog-id=20 op=UNLOAD Jun 4 23:51:15.751000 audit[719]: AVC avc: denied { associate } for pid=719 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 Jun 4 23:51:35.603000 audit: BPF prog-id=21 op=LOAD Jun 4 23:51:35.614000 audit: BPF prog-id=22 op=LOAD Jun 4 23:51:35.621000 audit: BPF prog-id=23 op=LOAD Jun 4 23:51:35.621000 audit: BPF prog-id=14 op=UNLOAD Jun 4 23:51:35.621000 audit: BPF prog-id=15 op=UNLOAD Jun 4 23:51:35.728000 audit: BPF prog-id=24 op=LOAD Jun 4 23:51:35.730000 audit: BPF prog-id=21 op=UNLOAD Jun 4 23:51:35.737000 audit: BPF prog-id=25 op=LOAD Jun 4 23:51:35.744000 audit: BPF prog-id=26 op=LOAD Jun 4 23:51:35.745000 audit: BPF prog-id=22 op=UNLOAD Jun 4 23:51:35.745000 audit: BPF prog-id=23 op=UNLOAD Jun 4 23:51:35.785000 audit: BPF prog-id=27 op=LOAD Jun 4 23:51:35.788000 audit: BPF prog-id=24 op=UNLOAD Jun 4 23:51:35.790000 audit: BPF prog-id=28 op=LOAD Jun 4 23:51:35.791000 audit: BPF prog-id=29 op=LOAD Jun 4 23:51:35.792000 audit: BPF prog-id=25 op=UNLOAD Jun 4 23:51:35.793000 audit: BPF prog-id=26 op=UNLOAD Jun 4 23:51:35.819000 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' Jun 4 23:51:35.830000 audit: BPF prog-id=27 op=UNLOAD Jun 4 23:51:35.863000 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' Jun 4 23:51:35.864000 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' Jun 4 23:51:36.611000 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' Jun 4 23:51:36.638000 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' Jun 4 23:51:36.650000 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' Jun 4 23:51:36.650000 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' Jun 4 23:51:36.664000 audit: BPF prog-id=30 op=LOAD Jun 4 23:51:36.667000 audit: BPF prog-id=31 op=LOAD Jun 4 23:51:36.670000 audit: BPF prog-id=32 op=LOAD Jun 4 23:51:36.671000 audit: BPF prog-id=28 op=UNLOAD Jun 4 23:51:36.673000 audit: BPF prog-id=29 op=UNLOAD Jun 4 23:51:36.713000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Jun 4 23:51:15.746705 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3033.2.4 /usr/share/oem/torcx/store /var/lib/torcx/store/3033.2.4 /var/lib/torcx/store]" Jun 4 23:51:35.588272 systemd[1]: Queued start job for default target Multi-User System. Jun 4 23:51:15.747651 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Jun 4 23:51:35.819275 systemd[1]: systemd-journald.service: Deactivated successfully. Jun 4 23:51:15.747668 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Jun 4 23:51:15.748191 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Jun 4 23:51:15.748201 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=debug msg="skipped missing lower profile" missing profile=oem Jun 4 23:51:15.748333 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Jun 4 23:51:15.748347 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Jun 4 23:51:15.748674 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Jun 4 23:51:15.748722 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Jun 4 23:51:15.748737 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Jun 4 23:51:15.750858 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Jun 4 23:51:15.750888 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Jun 4 23:51:15.750910 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" 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 Jun 4 23:51:15.750926 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Jun 4 23:51:15.750947 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" 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 Jun 4 23:51:15.750961 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:15Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Jun 4 23:51:33.740105 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:33Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Jun 4 23:51:33.752109 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:33Z" 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 Jun 4 23:51:33.752782 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:33Z" 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 Jun 4 23:51:33.753217 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:33Z" 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 Jun 4 23:51:33.753376 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:33Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Jun 4 23:51:33.753715 /usr/lib64/systemd/system-generators/torcx-generator[719]: time="2026-06-04T23:51:33Z" 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 Jun 4 23:51:36.726705 systemd[1]: Starting Apply Kernel Variables... Jun 4 23:51:36.737462 systemd[1]: Starting Coldplug All udev Devices... Jun 4 23:51:36.744660 systemd[1]: verity-setup.service: Deactivated successfully. Jun 4 23:51:36.749638 systemd[1]: Stopped verity-setup.service. Jun 4 23:51:36.752000 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' Jun 4 23:51:36.761642 systemd[1]: Condition check resulted in Set fake PV driver version for XenServer being skipped. Jun 4 23:51:36.769051 systemd[1]: Started Journal Service. Jun 4 23:51:36.769000 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' Jun 4 23:51:36.770337 systemd[1]: Mounted Huge Pages File System. Jun 4 23:51:36.774415 systemd[1]: Mounted POSIX Message Queue File System. Jun 4 23:51:36.785123 systemd[1]: Mounted External Media Directory. Jun 4 23:51:36.792457 systemd[1]: Mounted Kernel Debug File System. Jun 4 23:51:36.799317 systemd[1]: Mounted Kernel Trace File System. Jun 4 23:51:36.805306 systemd[1]: Mounted Temporary Directory /tmp. Jun 4 23:51:36.813015 systemd[1]: Finished Create missing system files. Jun 4 23:51:36.819000 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' Jun 4 23:51:36.821014 systemd[1]: Finished Create List of Static Device Nodes. Jun 4 23:51:36.825000 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' Jun 4 23:51:36.831952 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jun 4 23:51:36.832253 systemd[1]: Finished Load Kernel Module configfs. Jun 4 23:51:36.837000 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' Jun 4 23:51:36.837000 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' Jun 4 23:51:36.837953 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 4 23:51:36.838297 systemd[1]: Finished Load Kernel Module drm. Jun 4 23:51:36.842000 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' Jun 4 23:51:36.842000 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' Jun 4 23:51:36.843342 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jun 4 23:51:36.843787 systemd[1]: Finished Load Kernel Module fuse. Jun 4 23:51:36.847000 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' Jun 4 23:51:36.847000 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' Jun 4 23:51:36.850716 systemd[1]: Finished Remount Root and Kernel File Systems. Jun 4 23:51:36.857000 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' Jun 4 23:51:36.858407 systemd[1]: Finished Apply Kernel Variables. Jun 4 23:51:36.862000 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' Jun 4 23:51:36.884623 systemd[1]: Mounting FUSE Control File System... Jun 4 23:51:36.889929 systemd[1]: Mounting Kernel Configuration File System... Jun 4 23:51:36.894232 systemd[1]: Condition check resulted in Remount Root File System being skipped. Jun 4 23:51:36.898244 systemd[1]: Starting Rebuild Hardware Database... Jun 4 23:51:36.904093 systemd[1]: Starting Flush Journal to Persistent Storage... Jun 4 23:51:36.909161 systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped. Jun 4 23:51:36.913098 systemd[1]: Starting Load/Save Random Seed... Jun 4 23:51:36.917437 systemd[1]: Starting Create System Users... Jun 4 23:51:36.922129 systemd-journald[774]: Time spent on flushing to /var/log/journal/477609d1e66a4eed9ba14c01cdbaa162 is 33.294ms for 1014 entries. Jun 4 23:51:36.922129 systemd-journald[774]: System Journal (/var/log/journal/477609d1e66a4eed9ba14c01cdbaa162) is 8.0M, max 203.0M, 195.0M free. Jun 4 23:51:36.934000 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' Jun 4 23:51:36.955000 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' Jun 4 23:51:36.922372 systemd[1]: Finished Coldplug All udev Devices. Jun 4 23:51:36.941949 systemd[1]: Mounted FUSE Control File System. Jun 4 23:51:36.945835 systemd[1]: Mounted Kernel Configuration File System. Jun 4 23:51:36.951433 systemd[1]: Finished Load/Save Random Seed. Jun 4 23:51:36.955860 systemd[1]: Reached target First Boot Complete. Jun 4 23:51:36.966264 systemd[1]: Starting Wait for udev To Complete Device Initialization... Jun 4 23:51:36.974237 systemd-sysusers[785]: Creating group sgx with gid 999. Jun 4 23:51:36.975631 systemd-sysusers[785]: Creating group systemd-oom with gid 998. Jun 4 23:51:36.977034 systemd-sysusers[785]: Creating user systemd-oom (systemd Userspace OOM Killer) with uid 998 and gid 998. Jun 4 23:51:36.981773 systemd-sysusers[785]: Creating group systemd-timesync with gid 997. Jun 4 23:51:36.983910 systemd-sysusers[785]: Creating user systemd-timesync (systemd Time Synchronization) with uid 997 and gid 997. Jun 4 23:51:36.988133 systemd-sysusers[785]: Creating group systemd-coredump with gid 996. Jun 4 23:51:36.991323 systemd-sysusers[785]: Creating user systemd-coredump (systemd Core Dumper) with uid 996 and gid 996. Jun 4 23:51:36.993719 systemd[1]: Finished Flush Journal to Persistent Storage. Jun 4 23:51:36.997000 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' Jun 4 23:51:37.011786 systemd[1]: Finished Create System Users. Jun 4 23:51:37.014000 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' Jun 4 23:51:37.023142 systemd[1]: Starting Create Static Device Nodes in /dev... Jun 4 23:51:37.052136 systemd[1]: Finished Create Static Device Nodes in /dev. Jun 4 23:51:37.058000 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' Jun 4 23:51:37.390831 systemd[1]: Finished Rebuild Hardware Database. Jun 4 23:51:37.395000 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' Jun 4 23:51:37.411000 audit: BPF prog-id=33 op=LOAD Jun 4 23:51:37.411000 audit: BPF prog-id=34 op=LOAD Jun 4 23:51:37.411000 audit: BPF prog-id=35 op=LOAD Jun 4 23:51:37.412000 audit: BPF prog-id=17 op=UNLOAD Jun 4 23:51:37.412000 audit: BPF prog-id=18 op=UNLOAD Jun 4 23:51:37.414330 systemd[1]: Starting Rule-based Manager for Device Events and Files... Jun 4 23:51:37.457850 systemd[1]: Started Rule-based Manager for Device Events and Files. Jun 4 23:51:37.462000 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' Jun 4 23:51:37.471278 systemd[1]: Starting Network Configuration... Jun 4 23:51:37.469000 audit: BPF prog-id=36 op=LOAD Jun 4 23:51:37.514943 systemd-udevd[793]: Using default interface naming scheme 'v249'. Jun 4 23:51:37.520411 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Jun 4 23:51:37.526576 kernel: ACPI: Power Button [PWRF] Jun 4 23:51:37.529000 audit[799]: AVC avc: denied { confidentiality } for pid=799 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 Jun 4 23:51:37.541797 systemd-networkd[800]: lo: Link UP Jun 4 23:51:37.541806 systemd-networkd[800]: lo: Gained carrier Jun 4 23:51:37.542259 systemd-networkd[800]: Enumeration completed Jun 4 23:51:37.542399 systemd[1]: Started Network Configuration. Jun 4 23:51:37.545000 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' Jun 4 23:51:37.545053 systemd-networkd[800]: eth0: Link UP Jun 4 23:51:37.550626 systemd-networkd[800]: eth0: Gained carrier Jun 4 23:51:37.559698 systemd-networkd[800]: eth0: DHCPv4 address 10.0.0.3/16 via 10.0.0.1 Jun 4 23:51:37.578597 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jun 4 23:51:37.597033 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Jun 4 23:51:37.597267 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jun 4 23:51:37.602417 udevadm[787]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jun 4 23:51:37.607639 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Jun 4 23:51:37.621628 kernel: mousedev: PS/2 mouse device common for all mice Jun 4 23:51:37.965209 systemd[1]: Finished Wait for udev To Complete Device Initialization. Jun 4 23:51:37.971000 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' Jun 4 23:51:37.985818 systemd[1]: Starting Activation of LVM2 logical volumes... Jun 4 23:51:38.027375 lvm[821]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jun 4 23:51:38.067633 systemd[1]: Finished Activation of LVM2 logical volumes. Jun 4 23:51:38.072000 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' Jun 4 23:51:38.074838 systemd[1]: Reached target Local Encrypted Volumes. Jun 4 23:51:38.092266 systemd[1]: Starting Activation of LVM2 logical volumes... Jun 4 23:51:38.111610 lvm[822]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jun 4 23:51:38.150166 systemd[1]: Finished Activation of LVM2 logical volumes. Jun 4 23:51:38.155000 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' Jun 4 23:51:38.156734 systemd[1]: Reached target Preparation for Local File Systems. Jun 4 23:51:38.162235 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped. Jun 4 23:51:38.162376 systemd[1]: Reached target Containers. Jun 4 23:51:38.173186 systemd[1]: Starting File System Check on /dev/disk/by-label/OEM... Jun 4 23:51:38.324921 systemd[1]: Finished File System Check on /dev/disk/by-label/OEM. Jun 4 23:51:38.332000 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' Jun 4 23:51:38.350109 systemd[1]: Mounting /usr/share/oem... Jun 4 23:51:38.379980 kernel: BTRFS info (device vda6): disk space caching is enabled Jun 4 23:51:38.380762 kernel: BTRFS info (device vda6): has skinny extents Jun 4 23:51:38.395250 systemd[1]: Mounted /usr/share/oem. Jun 4 23:51:38.398206 systemd[1]: Reached target Local File Systems. Jun 4 23:51:38.417152 systemd[1]: Starting Rebuild Dynamic Linker Cache... Jun 4 23:51:38.425672 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jun 4 23:51:38.425938 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped. Jun 4 23:51:38.430055 systemd[1]: Starting Commit a transient machine-id on disk... Jun 4 23:51:38.446841 systemd[1]: Starting Create Volatile Files and Directories... Jun 4 23:51:38.468656 systemd-tmpfiles[848]: /usr/lib64/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Jun 4 23:51:38.470286 systemd-tmpfiles[848]: /usr/lib64/tmpfiles.d/systemd.conf:33: Duplicate line for path "/var/lib/systemd", ignoring. Jun 4 23:51:38.488101 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jun 4 23:51:38.489258 systemd[1]: Finished Commit a transient machine-id on disk. Jun 4 23:51:38.494000 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' Jun 4 23:51:38.720911 systemd-networkd[800]: eth0: Gained IPv6LL Jun 4 23:51:38.756274 systemd-tmpfiles[848]: Detected autofs mount point /boot during canonicalization of /boot. Jun 4 23:51:38.756313 systemd-tmpfiles[848]: Skipping /boot Jun 4 23:51:38.788002 systemd-tmpfiles[848]: Detected autofs mount point /boot during canonicalization of /boot. Jun 4 23:51:38.788058 systemd-tmpfiles[848]: Skipping /boot Jun 4 23:51:39.283096 systemd[1]: Finished Create Volatile Files and Directories. Jun 4 23:51:39.288000 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' Jun 4 23:51:39.649975 systemd[1]: Starting Load Security Auditing Rules... Jun 4 23:51:39.662358 systemd[1]: Starting Clean up broken links in /etc/ssl/certs... Jun 4 23:51:39.673443 systemd[1]: Starting Rebuild Journal Catalog... Jun 4 23:51:39.689000 audit: BPF prog-id=37 op=LOAD Jun 4 23:51:39.725000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Jun 4 23:51:39.726937 augenrules[866]: No rules Jun 4 23:51:39.731030 systemd[1]: Starting Network Name Resolution... Jun 4 23:51:39.736714 systemd[1]: Starting Network Time Synchronization... Jun 4 23:51:39.748034 systemd[1]: Starting Record System Boot/Shutdown in UTMP... Jun 4 23:51:39.753145 systemd[1]: Finished Load Security Auditing Rules. Jun 4 23:51:39.759843 systemd[1]: Finished Clean up broken links in /etc/ssl/certs. Jun 4 23:51:39.778207 systemd[1]: Condition check resulted in Update CA bundle at /etc/ssl/certs/ca-certificates.crt being skipped. Jun 4 23:51:39.780667 systemd[1]: Finished Record System Boot/Shutdown in UTMP. Jun 4 23:51:39.786253 systemd[1]: Finished Rebuild Journal Catalog. Jun 4 23:51:39.910398 systemd[1]: Started Network Time Synchronization. Jun 4 23:51:39.918302 systemd[1]: Reached target System Time Set. Jun 4 23:51:39.918631 systemd-timesyncd[873]: Initial synchronization to time server 10.0.0.1:123 (10.0.0.1). Jun 4 23:51:40.117683 systemd-resolved[872]: Positive Trust Anchors: Jun 4 23:51:40.117728 systemd-resolved[872]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 4 23:51:40.117752 systemd-resolved[872]: 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 Jun 4 23:51:40.120688 systemd[1]: Finished Rebuild Dynamic Linker Cache. Jun 4 23:51:40.121806 systemd-resolved[872]: Defaulting to hostname 'linux'. Jun 4 23:51:40.125000 systemd[1]: Started Network Name Resolution. Jun 4 23:51:40.128382 systemd[1]: Reached target Network. Jun 4 23:51:40.131166 systemd[1]: Reached target Host and Network Name Lookups. Jun 4 23:51:40.157452 systemd[1]: Starting Update is Completed... Jun 4 23:51:40.189027 systemd[1]: Finished Update is Completed. Jun 4 23:51:40.197315 systemd[1]: Reached target System Initialization. Jun 4 23:51:40.206332 systemd[1]: Started Watch for update engine configuration changes. Jun 4 23:51:40.210789 systemd[1]: Started Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jun 4 23:51:40.218214 systemd[1]: Started Daily Log Rotation. Jun 4 23:51:40.229835 systemd[1]: Started Weekly check for MD array's redundancy information.. Jun 4 23:51:40.238000 systemd[1]: Started Daily Cleanup of Temporary Directories. Jun 4 23:51:40.244137 systemd[1]: Condition check resulted in Update Engine Stub Timer being skipped. Jun 4 23:51:40.244315 systemd[1]: Reached target Path Units. Jun 4 23:51:40.250124 systemd[1]: Reached target Timer Units. Jun 4 23:51:40.263981 systemd[1]: Listening on D-Bus System Message Bus Socket. Jun 4 23:51:40.352017 systemd[1]: Starting Docker Socket for the API... Jun 4 23:51:40.413769 systemd[1]: Listening on OpenSSH Server Socket. Jun 4 23:51:40.425777 systemd[1]: Listening on Docker Socket for the API. Jun 4 23:51:40.431392 systemd[1]: Reached target Socket Units. Jun 4 23:51:40.436079 systemd[1]: Reached target Basic System. Jun 4 23:51:40.439912 systemd[1]: Condition check resulted in Configure Addon /usr/share/oem being skipped. Jun 4 23:51:40.439970 systemd[1]: Condition check resulted in Run Addon /usr/share/oem being skipped. Jun 4 23:51:40.451687 systemd[1]: Started D-Bus System Message Bus. Jun 4 23:51:40.460973 systemd[1]: Starting Extend Filesystems... Jun 4 23:51:40.465012 systemd[1]: Condition check resulted in Modifies /etc/environment for CoreOS being skipped. Jun 4 23:51:40.467667 systemd[1]: Starting Generate /run/flatcar/motd... Jun 4 23:51:40.483052 systemd[1]: Starting Install an ssh key from /proc/cmdline... Jun 4 23:51:40.492327 systemd[1]: Starting Generate sshd host keys... Jun 4 23:51:40.497768 systemd[1]: Condition check resulted in Load cloud-config from /usr/share/oem/cloud-config.yml being skipped. Jun 4 23:51:40.497887 systemd[1]: Reached target Load system-provided cloud configs. Jun 4 23:51:40.512741 systemd[1]: Starting User Login Management... Jun 4 23:51:40.519259 systemd[1]: Condition check resulted in TCG Core Services Daemon being skipped. Jun 4 23:51:40.519963 extend-filesystems[881]: Found sr0 Jun 4 23:51:40.530749 extend-filesystems[881]: Found vda Jun 4 23:51:40.530749 extend-filesystems[881]: Found vda1 Jun 4 23:51:40.530749 extend-filesystems[881]: Found vda2 Jun 4 23:51:40.530749 extend-filesystems[881]: Found vda3 Jun 4 23:51:40.530749 extend-filesystems[881]: Found usr Jun 4 23:51:40.530749 extend-filesystems[881]: Found vda4 Jun 4 23:51:40.530749 extend-filesystems[881]: Found vda6 Jun 4 23:51:40.530749 extend-filesystems[881]: Found vda7 Jun 4 23:51:40.530749 extend-filesystems[881]: Found vda9 Jun 4 23:51:40.530749 extend-filesystems[881]: Checking size of /dev/vda9 Jun 4 23:51:40.526831 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jun 4 23:51:40.529059 systemd[1]: Starting Update Engine... Jun 4 23:51:40.533578 systemd[1]: Condition check resulted in Load cloud-config from url defined in /proc/cmdline being skipped. Jun 4 23:51:40.534375 systemd[1]: Reached target Load user-provided cloud configs. Jun 4 23:51:40.544806 systemd[1]: motdgen.service: Deactivated successfully. Jun 4 23:51:40.545220 systemd[1]: Finished Generate /run/flatcar/motd. Jun 4 23:51:40.554844 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jun 4 23:51:40.555217 systemd[1]: Finished Install an ssh key from /proc/cmdline. Jun 4 23:51:40.638897 extend-filesystems[881]: Old size kept for /dev/vda9 Jun 4 23:51:40.646875 systemd[1]: extend-filesystems.service: Deactivated successfully. Jun 4 23:51:40.647308 systemd[1]: Finished Extend Filesystems. Jun 4 23:51:40.714193 update_engine[897]: I0604 23:51:40.711722 897 main.cc:89] Flatcar Update Engine starting Jun 4 23:51:40.747948 systemd-logind[894]: Watching system buttons on /dev/input/event1 (Power Button) Jun 4 23:51:40.748658 systemd-logind[894]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jun 4 23:51:40.767614 systemd[1]: Started Update Engine. Jun 4 23:51:40.768491 update_engine[897]: I0604 23:51:40.767798 897 update_check_scheduler.cc:74] Next update check in 9m45s Jun 4 23:51:40.777106 systemd-logind[894]: New seat seat0. Jun 4 23:51:40.801699 systemd[1]: Started Cluster reboot manager. Jun 4 23:51:40.812332 systemd[1]: Started User Login Management. Jun 4 23:51:41.079755 locksmithd[911]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jun 4 23:51:41.376959 sshd_keygen[898]: ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 Jun 4 23:51:41.512347 systemd[1]: Finished Generate sshd host keys. Jun 4 23:51:41.535904 systemd[1]: Starting Generate /run/issue... Jun 4 23:51:41.626322 systemd[1]: issuegen.service: Deactivated successfully. Jun 4 23:51:41.627013 systemd[1]: Finished Generate /run/issue. Jun 4 23:51:41.646147 systemd[1]: Starting Permit User Sessions... Jun 4 23:51:41.662254 systemd[1]: Finished Permit User Sessions. Jun 4 23:51:41.679131 systemd[1]: Started Getty on tty1. Jun 4 23:51:41.689009 systemd[1]: Started Serial Getty on ttyS0. Jun 4 23:51:41.693380 systemd[1]: Reached target Login Prompts. Jun 4 23:51:41.697756 systemd[1]: Reached target Multi-User System. Jun 4 23:51:41.750320 systemd[1]: Starting Record Runlevel Change in UTMP... Jun 4 23:51:41.784710 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Jun 4 23:51:41.786447 systemd[1]: Finished Record Runlevel Change in UTMP. Jun 4 23:51:41.790728 systemd[1]: Startup finished in 6.288s (kernel) + 7.502s (initrd) + 26.518s (userspace) = 40.309s. Jun 4 23:51:48.495368 systemd[1]: Created slice Slice /system/sshd. Jun 4 23:51:48.499048 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40464). Jun 4 23:51:48.639150 sshd[932]: Accepted publickey for core from 10.0.0.1 port 40464 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:51:48.646953 sshd[932]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:51:48.682946 systemd[1]: Created slice User Slice of UID 500. Jun 4 23:51:48.689989 systemd[1]: Starting User Runtime Directory /run/user/500... Jun 4 23:51:48.695740 systemd-logind[894]: New session 1 of user core. Jun 4 23:51:48.705319 systemd[1]: Finished User Runtime Directory /run/user/500. Jun 4 23:51:48.769350 systemd[1]: Starting User Manager for UID 500... Jun 4 23:51:48.777889 systemd[935]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:51:48.912424 systemd[935]: Queued start job for default target Main User Target. Jun 4 23:51:48.912899 systemd[935]: Reached target Paths. Jun 4 23:51:48.912917 systemd[935]: Reached target Sockets. Jun 4 23:51:48.912928 systemd[935]: Reached target Timers. Jun 4 23:51:48.912939 systemd[935]: Reached target Basic System. Jun 4 23:51:48.913040 systemd[935]: Reached target Main User Target. Jun 4 23:51:48.913056 systemd[935]: Startup finished in 122ms. Jun 4 23:51:48.913339 systemd[1]: Started User Manager for UID 500. Jun 4 23:51:48.927821 systemd[1]: Started Session 1 of User core. Jun 4 23:51:49.012761 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40480). Jun 4 23:51:49.093367 sshd[944]: Accepted publickey for core from 10.0.0.1 port 40480 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:51:49.094583 sshd[944]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:51:49.099999 systemd-logind[894]: New session 2 of user core. Jun 4 23:51:49.111034 systemd[1]: Started Session 2 of User core. Jun 4 23:51:49.203823 sshd[944]: pam_unix(sshd:session): session closed for user core Jun 4 23:51:49.211943 systemd[1]: sshd@1-10.0.0.3:22-10.0.0.1:40480.service: Deactivated successfully. Jun 4 23:51:49.220122 systemd[1]: session-2.scope: Deactivated successfully. Jun 4 23:51:49.221666 systemd-logind[894]: Session 2 logged out. Waiting for processes to exit. Jun 4 23:51:49.230963 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40490). Jun 4 23:51:49.233676 systemd-logind[894]: Removed session 2. Jun 4 23:51:49.281443 sshd[950]: Accepted publickey for core from 10.0.0.1 port 40490 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:51:49.283083 sshd[950]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:51:49.292935 systemd-logind[894]: New session 3 of user core. Jun 4 23:51:49.298389 systemd[1]: Started Session 3 of User core. Jun 4 23:51:49.363269 sshd[950]: pam_unix(sshd:session): session closed for user core Jun 4 23:51:49.377270 systemd[1]: sshd@2-10.0.0.3:22-10.0.0.1:40490.service: Deactivated successfully. Jun 4 23:51:49.381186 systemd[1]: session-3.scope: Deactivated successfully. Jun 4 23:51:49.388148 systemd-logind[894]: Session 3 logged out. Waiting for processes to exit. Jun 4 23:51:49.406201 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40494). Jun 4 23:51:49.407394 systemd-logind[894]: Removed session 3. Jun 4 23:51:49.501848 sshd[957]: Accepted publickey for core from 10.0.0.1 port 40494 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:51:49.506454 sshd[957]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:51:49.518650 systemd-logind[894]: New session 4 of user core. Jun 4 23:51:49.530945 systemd[1]: Started Session 4 of User core. Jun 4 23:51:49.628262 sshd[957]: pam_unix(sshd:session): session closed for user core Jun 4 23:51:49.646091 systemd[1]: sshd@3-10.0.0.3:22-10.0.0.1:40494.service: Deactivated successfully. Jun 4 23:51:49.648306 systemd[1]: session-4.scope: Deactivated successfully. Jun 4 23:51:49.652674 systemd-logind[894]: Session 4 logged out. Waiting for processes to exit. Jun 4 23:51:49.669263 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40498). Jun 4 23:51:49.672154 systemd-logind[894]: Removed session 4. Jun 4 23:51:49.744077 sshd[963]: Accepted publickey for core from 10.0.0.1 port 40498 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:51:49.745342 sshd[963]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:51:49.758002 systemd-logind[894]: New session 5 of user core. Jun 4 23:51:49.773267 systemd[1]: Started Session 5 of User core. Jun 4 23:51:50.004275 sudo[966]: core : PWD=/home/core ; USER=root ; COMMAND=/sbin/setenforce 1 Jun 4 23:51:50.004593 sudo[966]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jun 4 23:51:50.032624 sudo[966]: pam_unix(sudo:session): session closed for user root Jun 4 23:51:50.041132 sshd[963]: pam_unix(sshd:session): session closed for user core Jun 4 23:51:50.129881 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40508). Jun 4 23:51:50.143118 dbus-daemon[880]: [system] Reloaded configuration Jun 4 23:51:50.150803 systemd[1]: sshd@4-10.0.0.3:22-10.0.0.1:40498.service: Deactivated successfully. Jun 4 23:51:50.159028 systemd[1]: session-5.scope: Deactivated successfully. Jun 4 23:51:50.160375 systemd-logind[894]: Session 5 logged out. Waiting for processes to exit. Jun 4 23:51:50.162389 systemd-logind[894]: Removed session 5. Jun 4 23:51:50.229076 sshd[969]: Accepted publickey for core from 10.0.0.1 port 40508 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:51:50.230781 sshd[969]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:51:50.260062 systemd-logind[894]: New session 6 of user core. Jun 4 23:51:50.271303 systemd[1]: Started Session 6 of User core. Jun 4 23:51:50.389141 sudo[974]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Jun 4 23:51:50.392629 sudo[974]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jun 4 23:51:50.416444 sudo[974]: pam_unix(sudo:session): session closed for user root Jun 4 23:51:50.465218 sudo[973]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/systemctl restart audit-rules Jun 4 23:51:50.465620 sudo[973]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Jun 4 23:51:50.551274 systemd[1]: Stopping Load Security Auditing Rules... Jun 4 23:51:50.559000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Jun 4 23:51:50.563686 auditctl[977]: No rules Jun 4 23:51:50.564105 systemd[1]: audit-rules.service: Deactivated successfully. Jun 4 23:51:50.567674 systemd[1]: Stopped Load Security Auditing Rules. Jun 4 23:51:50.583468 kernel: kauditd_printk_skb: 56 callbacks suppressed Jun 4 23:51:50.588722 kernel: audit: type=1305 audit(1780617110.559:161): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Jun 4 23:51:50.591981 kernel: audit: type=1131 audit(1780617110.566:162): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:51:50.566000 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' Jun 4 23:51:50.642022 systemd[1]: Starting Load Security Auditing Rules... Jun 4 23:51:50.896139 augenrules[994]: No rules Jun 4 23:51:50.906273 systemd[1]: Finished Load Security Auditing Rules. Jun 4 23:51:50.906000 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' Jun 4 23:51:50.907926 sudo[973]: pam_unix(sudo:session): session closed for user root Jun 4 23:51:50.914086 sshd[969]: pam_unix(sshd:session): session closed for user core Jun 4 23:51:50.907000 audit[973]: USER_END pid=973 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' Jun 4 23:51:50.947393 kernel: audit: type=1130 audit(1780617110.906:163): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:51:50.951419 kernel: audit: type=1106 audit(1780617110.907:164): pid=973 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' Jun 4 23:51:50.951824 kernel: audit: type=1104 audit(1780617110.907:165): pid=973 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' Jun 4 23:51:50.907000 audit[973]: CRED_DISP pid=973 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' Jun 4 23:51:50.969210 systemd[1]: sshd@5-10.0.0.3:22-10.0.0.1:40508.service: Deactivated successfully. Jun 4 23:51:50.971638 kernel: audit: type=1106 audit(1780617110.915:166): pid=969 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' Jun 4 23:51:50.915000 audit[969]: USER_END pid=969 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' Jun 4 23:51:50.970458 systemd[1]: session-6.scope: Deactivated successfully. Jun 4 23:51:50.973398 systemd-logind[894]: Session 6 logged out. Waiting for processes to exit. Jun 4 23:51:50.978635 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40520). Jun 4 23:51:50.979732 systemd-logind[894]: Removed session 6. Jun 4 23:51:50.915000 audit[969]: CRED_DISP pid=969 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' Jun 4 23:51:51.003550 kernel: audit: type=1104 audit(1780617110.915:167): pid=969 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' Jun 4 23:51:50.969000 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.3:22-10.0.0.1:40508 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:51:51.091233 kernel: audit: type=1131 audit(1780617110.969:168): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.0.0.3:22-10.0.0.1:40508 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:51:50.978000 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.3:22-10.0.0.1:40520 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:51:51.114897 kernel: audit: type=1130 audit(1780617110.978:169): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.3:22-10.0.0.1:40520 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:51:51.114000 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' Jun 4 23:51:51.116613 sshd[1000]: Accepted publickey for core from 10.0.0.1 port 40520 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:51:51.141799 kernel: audit: type=1101 audit(1780617111.114:170): 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' Jun 4 23:51:51.137000 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' Jun 4 23:51:51.142263 sshd[1000]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:51:51.174578 systemd-logind[894]: New session 7 of user core. Jun 4 23:51:51.189658 systemd[1]: Started Session 7 of User core. Jun 4 23:51:51.208000 audit[1000]: USER_START pid=1000 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' Jun 4 23:51:51.209000 audit[1002]: CRED_ACQ pid=1002 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' Jun 4 23:51:51.270000 audit[1003]: USER_ACCT pid=1003 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' Jun 4 23:51:51.271000 audit[1003]: CRED_REFR pid=1003 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' Jun 4 23:51:51.271605 sudo[1003]: core : PWD=/home/core ; USER=root ; COMMAND=/bin/bash -c cat >/etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem </etc/coreos/update.conf.new </etc/coreos/update-payload-key.pub.pem < Jun 4 23:52:08.248578 update_engine[1258]: Jun 4 23:52:08.248578 update_engine[1258]: Jun 4 23:52:08.248578 update_engine[1258]: Jun 4 23:52:08.248578 update_engine[1258]: Jun 4 23:52:08.248578 update_engine[1258]: Jun 4 23:52:08.248578 update_engine[1258]: Jun 4 23:52:08.248578 update_engine[1258]: Jun 4 23:52:08.248578 update_engine[1258]: Jun 4 23:52:08.248578 update_engine[1258]: I0604 23:52:08.247970 1258 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Jun 4 23:52:08.249870 systemd-logind[894]: Removed session 24. Jun 4 23:52:08.261301 update_engine[1258]: I0604 23:52:08.260386 1258 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Jun 4 23:52:08.262169 update_engine[1258]: I0604 23:52:08.261824 1258 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Jun 4 23:52:08.355272 update_engine[1258]: I0604 23:52:08.355193 1258 libcurl_http_fetcher.cc:248] HTTP response code: 200 Jun 4 23:52:08.356331 update_engine[1258]: I0604 23:52:08.355379 1258 libcurl_http_fetcher.cc:305] Transfer completed (200), 791 bytes downloaded Jun 4 23:52:08.356331 update_engine[1258]: I0604 23:52:08.355391 1258 omaha_request_action.cc:619] Omaha request response: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.356331 update_engine[1258]: Jun 4 23:52:08.367346 update_engine[1258]: I0604 23:52:08.367246 1258 omaha_request_action.cc:447] Omaha Response manifest version = Jun 4 23:52:08.367346 update_engine[1258]: I0604 23:52:08.367321 1258 omaha_request_action.cc:470] Found 1 url(s) Jun 4 23:52:08.367346 update_engine[1258]: I0604 23:52:08.367336 1258 omaha_request_action.cc:506] Processing first of 1 package(s) Jun 4 23:52:08.367346 update_engine[1258]: I0604 23:52:08.367341 1258 omaha_request_action.cc:513] Omaha Response package name = update.gz Jun 4 23:52:08.367346 update_engine[1258]: I0604 23:52:08.367347 1258 omaha_request_action.cc:529] Url0: http://10.0.0.2:34567/packages/update.gz Jun 4 23:52:08.367346 update_engine[1258]: I0604 23:52:08.367354 1258 omaha_request_action.cc:541] Payload size = 451952160 bytes Jun 4 23:52:08.367698 update_engine[1258]: I0604 23:52:08.367367 1258 omaha_request_action.cc:565] Found 1 action(s). Processing the postinstall action. Jun 4 23:52:08.367698 update_engine[1258]: I0604 23:52:08.367450 1258 payload_state.cc:51] Resetting all persisted state as this is a new response Jun 4 23:52:08.367698 update_engine[1258]: I0604 23:52:08.367455 1258 payload_state.cc:360] Current Response Signature = Jun 4 23:52:08.367698 update_engine[1258]: NumURLs = 1 Jun 4 23:52:08.367698 update_engine[1258]: Url0 = http://10.0.0.2:34567/packages/update.gz Jun 4 23:52:08.367698 update_engine[1258]: Payload Size = 451952160 Jun 4 23:52:08.367698 update_engine[1258]: Payload Sha256 Hash = db+I1gGL63gF9fRuFyrYi5F42OkRy8ovPbuPsOWQYs4= Jun 4 23:52:08.367698 update_engine[1258]: Is Delta Payload = 0 Jun 4 23:52:08.367698 update_engine[1258]: Max Failure Count Per Url = 10 Jun 4 23:52:08.367698 update_engine[1258]: Disable Payload Backoff = 1 Jun 4 23:52:08.367888 update_engine[1258]: I0604 23:52:08.367745 1258 payload_state.cc:381] Payload Attempt Number = 0 Jun 4 23:52:08.367888 update_engine[1258]: I0604 23:52:08.367776 1258 payload_state.cc:404] Current URL Index = 0 Jun 4 23:52:08.367888 update_engine[1258]: I0604 23:52:08.367797 1258 payload_state.cc:425] Current URL (Url0)'s Failure Count = 0 Jun 4 23:52:08.367888 update_engine[1258]: I0604 23:52:08.367818 1258 payload_state.cc:287] Resetting backoff expiry time as payload backoff is disabled Jun 4 23:52:08.367888 update_engine[1258]: I0604 23:52:08.367821 1258 payload_state.cc:452] Backoff Expiry Time = 01/01/70 00:00:00 UTC Jun 4 23:52:08.367888 update_engine[1258]: I0604 23:52:08.367844 1258 payload_state.cc:203] Payload backoff logic is disabled. Can proceed with the download Jun 4 23:52:08.367888 update_engine[1258]: I0604 23:52:08.367857 1258 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction Jun 4 23:52:08.367888 update_engine[1258]: I0604 23:52:08.367861 1258 omaha_response_handler_action.cc:43] Using Url0 as the download url this time Jun 4 23:52:08.367888 update_engine[1258]: I0604 23:52:08.367872 1258 prefs.cc:51] update-state-next-operation not present in /var/lib/update_engine/prefs Jun 4 23:52:08.367888 update_engine[1258]: E0604 23:52:08.367875 1258 payload_processor.cc:488] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed. Jun 4 23:52:08.370236 update_engine[1258]: I0604 23:52:08.369725 1258 omaha_response_handler_action.cc:85] Using this install plan: Jun 4 23:52:08.370236 update_engine[1258]: I0604 23:52:08.370288 1258 install_plan.cc:53] InstallPlan: , new_update, url: http://10.0.0.2:34567/packages/update.gz, payload size: 451952160, payload hash: db+I1gGL63gF9fRuFyrYi5F42OkRy8ovPbuPsOWQYs4=, partition_path: /dev/vda4, kernel_path: /boot/flatcar/vmlinuz-b, pcr_policy_path: /var/lib/update_engine/pcrs-b.zip, old_partition_path: /dev/vda3, old_kernel_path: /boot/flatcar/vmlinuz-a Jun 4 23:52:08.370766 update_engine[1258]: I0604 23:52:08.370623 1258 action_processor.cc:82] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction Jun 4 23:52:08.376000 audit[1274]: USER_ACCT pid=1274 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' Jun 4 23:52:08.378287 sshd[1274]: Accepted publickey for core from 10.0.0.1 port 34780 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:52:08.386120 update_engine[1258]: I0604 23:52:08.383443 1258 filesystem_copier_action.cc:296] Filesystem size: 1073741824 Jun 4 23:52:08.384000 audit[1274]: CRED_ACQ pid=1274 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' Jun 4 23:52:08.386867 sshd[1274]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:52:08.427032 systemd-logind[894]: New session 25 of user core. Jun 4 23:52:08.460845 systemd[1]: Started Session 25 of User core. Jun 4 23:52:08.584000 audit[1274]: USER_START pid=1274 uid=0 auid=500 ses=25 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' Jun 4 23:52:08.586000 audit[1286]: CRED_ACQ pid=1286 uid=0 auid=500 ses=25 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' Jun 4 23:52:08.828332 sshd[1274]: pam_unix(sshd:session): session closed for user core Jun 4 23:52:08.837000 audit[1274]: USER_END pid=1274 uid=0 auid=500 ses=25 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' Jun 4 23:52:08.837000 audit[1274]: CRED_DISP pid=1274 uid=0 auid=500 ses=25 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' Jun 4 23:52:08.842389 systemd[1]: sshd@24-10.0.0.3:22-10.0.0.1:34780.service: Deactivated successfully. Jun 4 23:52:08.842000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@24-10.0.0.3:22-10.0.0.1:34780 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:08.844898 systemd[1]: session-25.scope: Deactivated successfully. Jun 4 23:52:08.847363 systemd-logind[894]: Session 25 logged out. Waiting for processes to exit. Jun 4 23:52:08.857735 systemd-logind[894]: Removed session 25. Jun 4 23:52:18.916159 kernel: kauditd_printk_skb: 14 callbacks suppressed Jun 4 23:52:18.930561 kernel: audit: type=1130 audit(1780617138.905:702): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@25-10.0.0.3:22-10.0.0.1:43594 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:18.905000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@25-10.0.0.3:22-10.0.0.1:43594 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:18.905367 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:43594). Jun 4 23:52:19.062000 audit[1291]: USER_ACCT pid=1291 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' Jun 4 23:52:19.069041 sshd[1291]: Accepted publickey for core from 10.0.0.1 port 43594 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:52:19.073410 sshd[1291]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:52:19.072000 audit[1291]: CRED_ACQ pid=1291 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' Jun 4 23:52:19.102138 systemd-logind[894]: New session 26 of user core. Jun 4 23:52:19.114861 kernel: audit: type=1101 audit(1780617139.062:703): pid=1291 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' Jun 4 23:52:19.115455 kernel: audit: type=1103 audit(1780617139.072:704): pid=1291 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' Jun 4 23:52:19.115555 kernel: audit: type=1006 audit(1780617139.072:705): pid=1291 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=26 res=1 Jun 4 23:52:19.149981 systemd[1]: Started Session 26 of User core. Jun 4 23:52:19.202000 audit[1291]: USER_START pid=1291 uid=0 auid=500 ses=26 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' Jun 4 23:52:19.221000 audit[1293]: CRED_ACQ pid=1293 uid=0 auid=500 ses=26 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' Jun 4 23:52:19.253672 kernel: audit: type=1105 audit(1780617139.202:706): pid=1291 uid=0 auid=500 ses=26 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' Jun 4 23:52:19.254773 kernel: audit: type=1103 audit(1780617139.221:707): pid=1293 uid=0 auid=500 ses=26 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' Jun 4 23:52:19.621317 sshd[1291]: pam_unix(sshd:session): session closed for user core Jun 4 23:52:19.623000 audit[1291]: USER_END pid=1291 uid=0 auid=500 ses=26 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' Jun 4 23:52:19.632340 systemd[1]: sshd@25-10.0.0.3:22-10.0.0.1:43594.service: Deactivated successfully. Jun 4 23:52:19.633706 systemd[1]: session-26.scope: Deactivated successfully. Jun 4 23:52:19.636293 systemd-logind[894]: Session 26 logged out. Waiting for processes to exit. Jun 4 23:52:19.638206 systemd-logind[894]: Removed session 26. Jun 4 23:52:19.626000 audit[1291]: CRED_DISP pid=1291 uid=0 auid=500 ses=26 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' Jun 4 23:52:19.677189 kernel: audit: type=1106 audit(1780617139.623:708): pid=1291 uid=0 auid=500 ses=26 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' Jun 4 23:52:19.683733 kernel: audit: type=1104 audit(1780617139.626:709): pid=1291 uid=0 auid=500 ses=26 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' Jun 4 23:52:19.684371 kernel: audit: type=1131 audit(1780617139.631:710): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@25-10.0.0.3:22-10.0.0.1:43594 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:19.631000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@25-10.0.0.3:22-10.0.0.1:43594 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:30.111160 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37038). Jun 4 23:52:30.110000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@26-10.0.0.3:22-10.0.0.1:37038 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:30.175868 kernel: audit: type=1130 audit(1780617150.110:711): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@26-10.0.0.3:22-10.0.0.1:37038 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:30.227000 audit[1298]: USER_ACCT pid=1298 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' Jun 4 23:52:30.231985 sshd[1298]: Accepted publickey for core from 10.0.0.1 port 37038 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:52:30.254301 sshd[1298]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:52:30.251000 audit[1298]: CRED_ACQ pid=1298 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' Jun 4 23:52:30.263006 systemd-logind[894]: New session 27 of user core. Jun 4 23:52:30.307781 kernel: audit: type=1101 audit(1780617150.227:712): pid=1298 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' Jun 4 23:52:30.307830 kernel: audit: type=1103 audit(1780617150.251:713): pid=1298 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' Jun 4 23:52:30.307853 kernel: audit: type=1006 audit(1780617150.252:714): pid=1298 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=27 res=1 Jun 4 23:52:30.307765 systemd[1]: Started Session 27 of User core. Jun 4 23:52:30.346000 audit[1298]: USER_START pid=1298 uid=0 auid=500 ses=27 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' Jun 4 23:52:30.377000 audit[1300]: CRED_ACQ pid=1300 uid=0 auid=500 ses=27 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' Jun 4 23:52:30.429453 kernel: audit: type=1105 audit(1780617150.346:715): pid=1298 uid=0 auid=500 ses=27 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' Jun 4 23:52:30.432281 kernel: audit: type=1103 audit(1780617150.377:716): pid=1300 uid=0 auid=500 ses=27 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' Jun 4 23:52:30.609909 sshd[1298]: pam_unix(sshd:session): session closed for user core Jun 4 23:52:30.614000 audit[1298]: USER_END pid=1298 uid=0 auid=500 ses=27 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' Jun 4 23:52:30.630194 systemd[1]: sshd@26-10.0.0.3:22-10.0.0.1:37038.service: Deactivated successfully. Jun 4 23:52:30.642049 systemd[1]: session-27.scope: Deactivated successfully. Jun 4 23:52:30.683202 kernel: audit: type=1106 audit(1780617150.614:717): pid=1298 uid=0 auid=500 ses=27 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' Jun 4 23:52:30.688419 kernel: audit: type=1104 audit(1780617150.615:718): pid=1298 uid=0 auid=500 ses=27 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' Jun 4 23:52:30.689432 kernel: audit: type=1131 audit(1780617150.634:719): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@26-10.0.0.3:22-10.0.0.1:37038 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:30.615000 audit[1298]: CRED_DISP pid=1298 uid=0 auid=500 ses=27 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' Jun 4 23:52:30.634000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@26-10.0.0.3:22-10.0.0.1:37038 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:30.688565 systemd-logind[894]: Session 27 logged out. Waiting for processes to exit. Jun 4 23:52:30.698094 systemd-logind[894]: Removed session 27. Jun 4 23:52:40.975961 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:40876). Jun 4 23:52:40.974000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@27-10.0.0.3:22-10.0.0.1:40876 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:41.000850 kernel: audit: type=1130 audit(1780617160.974:720): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@27-10.0.0.3:22-10.0.0.1:40876 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:41.055000 audit[1305]: USER_ACCT pid=1305 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' Jun 4 23:52:41.090959 kernel: audit: type=1101 audit(1780617161.055:721): pid=1305 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' Jun 4 23:52:41.091243 sshd[1305]: Accepted publickey for core from 10.0.0.1 port 40876 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:52:41.091384 sshd[1305]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:52:41.087000 audit[1305]: CRED_ACQ pid=1305 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' Jun 4 23:52:41.119007 kernel: audit: type=1103 audit(1780617161.087:722): pid=1305 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' Jun 4 23:52:41.119834 kernel: audit: type=1006 audit(1780617161.089:723): pid=1305 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=28 res=1 Jun 4 23:52:41.135717 systemd-logind[894]: New session 28 of user core. Jun 4 23:52:41.145756 systemd[1]: Started Session 28 of User core. Jun 4 23:52:41.171000 audit[1305]: USER_START pid=1305 uid=0 auid=500 ses=28 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' Jun 4 23:52:41.206366 kernel: audit: type=1105 audit(1780617161.171:724): pid=1305 uid=0 auid=500 ses=28 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' Jun 4 23:52:41.212168 kernel: audit: type=1103 audit(1780617161.178:725): pid=1307 uid=0 auid=500 ses=28 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' Jun 4 23:52:41.178000 audit[1307]: CRED_ACQ pid=1307 uid=0 auid=500 ses=28 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' Jun 4 23:52:41.353132 sshd[1305]: pam_unix(sshd:session): session closed for user core Jun 4 23:52:41.359000 audit[1305]: USER_END pid=1305 uid=0 auid=500 ses=28 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' Jun 4 23:52:41.364177 systemd[1]: sshd@27-10.0.0.3:22-10.0.0.1:40876.service: Deactivated successfully. Jun 4 23:52:41.365377 systemd[1]: session-28.scope: Deactivated successfully. Jun 4 23:52:41.366978 systemd-logind[894]: Session 28 logged out. Waiting for processes to exit. Jun 4 23:52:41.382635 systemd-logind[894]: Removed session 28. Jun 4 23:52:41.394082 kernel: audit: type=1106 audit(1780617161.359:726): pid=1305 uid=0 auid=500 ses=28 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' Jun 4 23:52:41.395645 kernel: audit: type=1104 audit(1780617161.361:727): pid=1305 uid=0 auid=500 ses=28 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' Jun 4 23:52:41.361000 audit[1305]: CRED_DISP pid=1305 uid=0 auid=500 ses=28 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' Jun 4 23:52:41.364000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@27-10.0.0.3:22-10.0.0.1:40876 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:41.439443 kernel: audit: type=1131 audit(1780617161.364:728): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@27-10.0.0.3:22-10.0.0.1:40876 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:51.390442 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:38880). Jun 4 23:52:51.390000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@28-10.0.0.3:22-10.0.0.1:38880 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:51.441390 kernel: audit: type=1130 audit(1780617171.390:729): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@28-10.0.0.3:22-10.0.0.1:38880 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:52.197000 audit[1314]: USER_ACCT pid=1314 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' Jun 4 23:52:52.202389 sshd[1314]: Accepted publickey for core from 10.0.0.1 port 38880 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:52:52.212648 sshd[1314]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:52:52.211000 audit[1314]: CRED_ACQ pid=1314 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' Jun 4 23:52:52.256716 systemd-logind[894]: New session 29 of user core. Jun 4 23:52:52.328671 kernel: audit: type=1101 audit(1780617172.197:730): pid=1314 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' Jun 4 23:52:52.328868 kernel: audit: type=1103 audit(1780617172.211:731): pid=1314 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' Jun 4 23:52:52.328882 kernel: audit: type=1006 audit(1780617172.211:732): pid=1314 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=29 res=1 Jun 4 23:52:52.328803 systemd[1]: Started Session 29 of User core. Jun 4 23:52:52.345000 audit[1314]: USER_START pid=1314 uid=0 auid=500 ses=29 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' Jun 4 23:52:52.378697 kernel: audit: type=1105 audit(1780617172.345:733): pid=1314 uid=0 auid=500 ses=29 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' Jun 4 23:52:52.380000 audit[1316]: CRED_ACQ pid=1316 uid=0 auid=500 ses=29 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' Jun 4 23:52:52.402788 kernel: audit: type=1103 audit(1780617172.380:734): pid=1316 uid=0 auid=500 ses=29 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' Jun 4 23:52:52.460773 sshd[1314]: pam_unix(sshd:session): session closed for user core Jun 4 23:52:52.462000 audit[1314]: USER_END pid=1314 uid=0 auid=500 ses=29 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' Jun 4 23:52:52.466457 systemd[1]: sshd@28-10.0.0.3:22-10.0.0.1:38880.service: Deactivated successfully. Jun 4 23:52:52.468163 systemd[1]: session-29.scope: Deactivated successfully. Jun 4 23:52:52.469335 systemd-logind[894]: Session 29 logged out. Waiting for processes to exit. Jun 4 23:52:52.470886 systemd-logind[894]: Removed session 29. Jun 4 23:52:52.462000 audit[1314]: CRED_DISP pid=1314 uid=0 auid=500 ses=29 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' Jun 4 23:52:52.535796 kernel: audit: type=1106 audit(1780617172.462:735): pid=1314 uid=0 auid=500 ses=29 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' Jun 4 23:52:52.548682 kernel: audit: type=1104 audit(1780617172.462:736): pid=1314 uid=0 auid=500 ses=29 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' Jun 4 23:52:52.570211 kernel: audit: type=1131 audit(1780617172.467:737): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@28-10.0.0.3:22-10.0.0.1:38880 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:52.467000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@28-10.0.0.3:22-10.0.0.1:38880 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:52:52.582395 update_engine[1258]: I0604 23:52:52.507661 1258 update_attempter.cc:495] Already updated boot flags. Skipping. Jun 4 23:53:02.789000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@29-10.0.0.3:22-10.0.0.1:37600 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:53:02.790552 systemd[1]: Started OpenSSH per-connection server daemon (10.0.0.1:37600). Jun 4 23:53:02.812714 kernel: audit: type=1130 audit(1780617182.789:738): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@29-10.0.0.3:22-10.0.0.1:37600 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:53:02.926000 audit[1321]: USER_ACCT pid=1321 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' Jun 4 23:53:02.931657 sshd[1321]: Accepted publickey for core from 10.0.0.1 port 37600 ssh2: RSA SHA256:mb6NoKyb2ZFjTnTSET0n4D7iVhC3qnu5feXFNHAQULQ Jun 4 23:53:02.951019 sshd[1321]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jun 4 23:53:02.946000 audit[1321]: CRED_ACQ pid=1321 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' Jun 4 23:53:02.981612 systemd-logind[894]: New session 30 of user core. Jun 4 23:53:03.193605 kernel: audit: type=1101 audit(1780617182.926:739): pid=1321 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' Jun 4 23:53:03.193925 kernel: audit: type=1103 audit(1780617182.946:740): pid=1321 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' Jun 4 23:53:03.193949 kernel: audit: type=1006 audit(1780617182.946:741): pid=1321 uid=0 subj=system_u:system_r:kernel_t:s0 old-auid=4294967295 auid=500 tty=(none) old-ses=4294967295 ses=30 res=1 Jun 4 23:53:03.192366 systemd[1]: Started Session 30 of User core. Jun 4 23:53:03.257000 audit[1321]: USER_START pid=1321 uid=0 auid=500 ses=30 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' Jun 4 23:53:03.262000 audit[1323]: CRED_ACQ pid=1323 uid=0 auid=500 ses=30 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' Jun 4 23:53:03.320867 kernel: audit: type=1105 audit(1780617183.257:742): pid=1321 uid=0 auid=500 ses=30 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' Jun 4 23:53:03.322419 kernel: audit: type=1103 audit(1780617183.262:743): pid=1323 uid=0 auid=500 ses=30 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' Jun 4 23:53:03.408452 sshd[1321]: pam_unix(sshd:session): session closed for user core Jun 4 23:53:03.409000 audit[1321]: USER_END pid=1321 uid=0 auid=500 ses=30 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' Jun 4 23:53:03.412560 systemd[1]: sshd@29-10.0.0.3:22-10.0.0.1:37600.service: Deactivated successfully. Jun 4 23:53:03.413805 systemd[1]: session-30.scope: Deactivated successfully. Jun 4 23:53:03.414938 systemd-logind[894]: Session 30 logged out. Waiting for processes to exit. Jun 4 23:53:03.416656 systemd-logind[894]: Removed session 30. Jun 4 23:53:03.409000 audit[1321]: CRED_DISP pid=1321 uid=0 auid=500 ses=30 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' Jun 4 23:53:03.486230 kernel: audit: type=1106 audit(1780617183.409:744): pid=1321 uid=0 auid=500 ses=30 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' Jun 4 23:53:03.531264 kernel: audit: type=1104 audit(1780617183.409:745): pid=1321 uid=0 auid=500 ses=30 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' Jun 4 23:53:03.532442 kernel: audit: type=1131 audit(1780617183.411:746): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@29-10.0.0.3:22-10.0.0.1:37600 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:53:03.411000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@29-10.0.0.3:22-10.0.0.1:37600 comm="systemd" exe="/usr/lib64/systemd/systemd" hostname=? addr=? terminal=? res=success' Jun 4 23:53:10.611343 update_engine[1258]: I0604 23:53:10.608904 1258 filesystem_copier_action.cc:274] Hash: W2tlmDO1e7ue6lfdobBruQSsP93+fWBhNnXM6T/sIeY= Jun 4 23:53:10.612987 update_engine[1258]: I0604 23:53:10.611366 1258 action_processor.cc:82] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting KernelCopierAction Jun 4 23:53:11.301714 update_engine[1258]: E0604 23:53:11.300856 1258 kernel_copier_action.cc:60] Failed to copy kernel from /boot/flatcar/vmlinuz-a to /boot/flatcar/vmlinuz-b Jun 4 23:53:11.302691 update_engine[1258]: I0604 23:53:11.301880 1258 action_processor.cc:68] ActionProcessor::ActionComplete: KernelCopierAction action failed. Aborting processing. Jun 4 23:53:11.302691 update_engine[1258]: I0604 23:53:11.301892 1258 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type KernelCopierAction Jun 4 23:53:11.302691 update_engine[1258]: I0604 23:53:11.301896 1258 update_attempter.cc:302] Processing Done. Jun 4 23:53:11.302691 update_engine[1258]: E0604 23:53:11.301973 1258 update_attempter.cc:615] Update failed. Jun 4 23:53:11.302691 update_engine[1258]: I0604 23:53:11.302023 1258 payload_state.cc:97] Updating payload state for error code: 1 (kActionCodeError) Jun 4 23:53:11.302691 update_engine[1258]: I0604 23:53:11.302029 1258 payload_state.cc:276] Incrementing the URL failure count Jun 4 23:53:11.302691 update_engine[1258]: I0604 23:53:11.302035 1258 payload_state.cc:425] Current URL (Url0)'s Failure Count = 1 Jun 4 23:53:11.304018 update_engine[1258]: I0604 23:53:11.303750 1258 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Jun 4 23:53:11.304018 update_engine[1258]: I0604 23:53:11.303865 1258 omaha_request_action.cc:268] Posting an Omaha request to http://10.0.0.2:34567/v1/update Jun 4 23:53:11.304018 update_engine[1258]: I0604 23:53:11.303872 1258 omaha_request_action.cc:269] Request: Jun 4 23:53:11.304018 update_engine[1258]: Jun 4 23:53:11.304018 update_engine[1258]: Jun 4 23:53:11.304018 update_engine[1258]: Jun 4 23:53:11.304018 update_engine[1258]: Jun 4 23:53:11.304018 update_engine[1258]: Jun 4 23:53:11.304018 update_engine[1258]: Jun 4 23:53:11.304018 update_engine[1258]: I0604 23:53:11.303879 1258 libcurl_http_fetcher.cc:48] Starting/Resuming transfer Jun 4 23:53:11.306829 update_engine[1258]: I0604 23:53:11.306630 1258 libcurl_http_fetcher.cc:152] Setting up curl options for HTTP Jun 4 23:53:11.307331 update_engine[1258]: I0604 23:53:11.307255 1258 libcurl_http_fetcher.cc:435] Setting up timeout source: 1 seconds. Jun 4 23:53:11.684217 update_engine[1258]: I0604 23:53:11.682228 1258 libcurl_http_fetcher.cc:248] HTTP response code: 200 Jun 4 23:53:11.684217 update_engine[1258]: I0604 23:53:11.682766 1258 libcurl_http_fetcher.cc:305] Transfer completed (200), 241 bytes downloaded Jun 4 23:53:11.684217 update_engine[1258]: I0604 23:53:11.682777 1258 omaha_request_action.cc:619] Omaha request response: Jun 4 23:53:11.684217 update_engine[1258]: Jun 4 23:53:11.684217 update_engine[1258]: Jun 4 23:53:11.684217 update_engine[1258]: Jun 4 23:53:11.684217 update_engine[1258]: Jun 4 23:53:11.684217 update_engine[1258]: Jun 4 23:53:11.684217 update_engine[1258]: Jun 4 23:53:11.684217 update_engine[1258]: E0604 23:53:11.684224 1258 omaha_request_action.cc:626] HTTP reported success but Omaha reports an error. Jun 4 23:53:11.696765 update_engine[1258]: I0604 23:53:11.684345 1258 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jun 4 23:53:11.696765 update_engine[1258]: I0604 23:53:11.684350 1258 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Jun 4 23:53:11.696765 update_engine[1258]: I0604 23:53:11.684352 1258 update_attempter.cc:302] Processing Done. Jun 4 23:53:11.696765 update_engine[1258]: I0604 23:53:11.684357 1258 update_attempter.cc:306] Error event sent.