May 22 18:52:00.663522 kernel: Linux version 6.12.90-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 15.2.1_p20260214 p5) 15.2.1 20260214, GNU ld (Gentoo 2.46.0 p1) 2.46.0) #1 SMP PREEMPT_DYNAMIC Fri May 22 16:15:53 -00 2026 May 22 18:52:00.663572 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=tty1 console=ttyS0,115200n8 earlyprintk=ttyS0,115200 flatcar.first_boot=detected flatcar.oem.id=azure flatcar.autologin verity.usrhash=52c0da84a3f2e3835ffa746c8f820a8956b2e6f69edb5b3b2e9f90b6eb0ea633 May 22 18:52:00.663584 kernel: BIOS-provided physical RAM map: May 22 18:52:00.663601 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable May 22 18:52:00.663611 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved May 22 18:52:00.663618 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000044fdfff] usable May 22 18:52:00.663626 kernel: BIOS-e820: [mem 0x00000000044fe000-0x00000000048fdfff] reserved May 22 18:52:00.663633 kernel: BIOS-e820: [mem 0x00000000048fe000-0x000000003ff1efff] usable May 22 18:52:00.663645 kernel: BIOS-e820: [mem 0x000000003ff1f000-0x000000003ffc8fff] reserved May 22 18:52:00.663666 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data May 22 18:52:00.663675 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS May 22 18:52:00.663680 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable May 22 18:52:00.663693 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable May 22 18:52:00.663705 kernel: printk: legacy bootconsole [earlyser0] enabled May 22 18:52:00.663713 kernel: NX (Execute Disable) protection: active May 22 18:52:00.663720 kernel: APIC: Static calls initialized May 22 18:52:00.663727 kernel: efi: EFI v2.7 by Microsoft May 22 18:52:00.663745 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff88000 SMBIOS 3.0=0x3ff86000 MEMATTR=0x3ea93018 RNG=0x3ffd2018 May 22 18:52:00.663753 kernel: random: crng init done May 22 18:52:00.663763 kernel: secureboot: Secure boot disabled May 22 18:52:00.663771 kernel: SMBIOS 3.1.0 present. May 22 18:52:00.663776 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 01/08/2026 May 22 18:52:00.663783 kernel: DMI: Memory slots populated: 2/2 May 22 18:52:00.663791 kernel: Hypervisor detected: Microsoft Hyper-V May 22 18:52:00.663804 kernel: Hyper-V: privilege flags low 0xae7f, high 0x3b8030, hints 0x9e4e24, misc 0xe0bed7b2 May 22 18:52:00.663815 kernel: Hyper-V: Nested features: 0x3e0101 May 22 18:52:00.663824 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 May 22 18:52:00.663831 kernel: Hyper-V: Using hypercall for remote TLB flush May 22 18:52:00.663838 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns May 22 18:52:00.663843 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns May 22 18:52:00.663850 kernel: tsc: Detected 2300.001 MHz processor May 22 18:52:00.663858 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved May 22 18:52:00.663882 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable May 22 18:52:00.663896 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x10000000000 May 22 18:52:00.663906 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs May 22 18:52:00.663924 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT May 22 18:52:00.663939 kernel: e820: update [mem 0x48000000-0xffffffff] usable ==> reserved May 22 18:52:00.663958 kernel: last_pfn = 0x40000 max_arch_pfn = 0x10000000000 May 22 18:52:00.663968 kernel: Using GB pages for direct mapping May 22 18:52:00.663975 kernel: ACPI: Early table checksum verification disabled May 22 18:52:00.663988 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) May 22 18:52:00.664007 kernel: ACPI: XSDT 0x000000003FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:52:00.664015 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:52:00.664025 kernel: ACPI: DSDT 0x000000003FFD6000 01E22B (v02 MSFTVM DSDT01 00000001 INTL 20230628) May 22 18:52:00.664040 kernel: ACPI: FACS 0x000000003FFFE000 000040 May 22 18:52:00.664053 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:52:00.664061 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:52:00.664072 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:52:00.664084 kernel: ACPI: APIC 0x000000003FFD5000 000058 (v05 HVLITE HVLITETB 00000000 MSHV 00000000) May 22 18:52:00.664095 kernel: ACPI: SRAT 0x000000003FFD4000 0000A0 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) May 22 18:52:00.664111 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:52:00.664122 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] May 22 18:52:00.664127 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff422a] May 22 18:52:00.664132 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] May 22 18:52:00.664157 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] May 22 18:52:00.664168 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] May 22 18:52:00.664176 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] May 22 18:52:00.664182 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5057] May 22 18:52:00.664187 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd409f] May 22 18:52:00.664203 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] May 22 18:52:00.664214 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] May 22 18:52:00.664230 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] May 22 18:52:00.664246 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00001000-0x2bfffffff] May 22 18:52:00.664262 kernel: NODE_DATA(0) allocated [mem 0x2bfff8dc0-0x2bfffffff] May 22 18:52:00.664275 kernel: Zone ranges: May 22 18:52:00.664294 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] May 22 18:52:00.664306 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] May 22 18:52:00.664320 kernel: Normal [mem 0x0000000100000000-0x00000002bfffffff] May 22 18:52:00.664332 kernel: Device empty May 22 18:52:00.664343 kernel: Movable zone start for each node May 22 18:52:00.664351 kernel: Early memory node ranges May 22 18:52:00.664360 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] May 22 18:52:00.664375 kernel: node 0: [mem 0x0000000000100000-0x00000000044fdfff] May 22 18:52:00.664387 kernel: node 0: [mem 0x00000000048fe000-0x000000003ff1efff] May 22 18:52:00.664396 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] May 22 18:52:00.664410 kernel: node 0: [mem 0x0000000100000000-0x00000002bfffffff] May 22 18:52:00.664425 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff] May 22 18:52:00.664435 kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 22 18:52:00.664443 kernel: On node 0, zone DMA: 96 pages in unavailable ranges May 22 18:52:00.664457 kernel: On node 0, zone DMA32: 1024 pages in unavailable ranges May 22 18:52:00.664471 kernel: On node 0, zone DMA32: 224 pages in unavailable ranges May 22 18:52:00.664485 kernel: ACPI: PM-Timer IO Port: 0x408 May 22 18:52:00.664493 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) May 22 18:52:00.664506 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 May 22 18:52:00.664518 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) May 22 18:52:00.664530 kernel: ACPI: Using ACPI (MADT) for SMP configuration information May 22 18:52:00.664546 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 May 22 18:52:00.664558 kernel: TSC deadline timer available May 22 18:52:00.664571 kernel: CPU topo: Max. logical packages: 1 May 22 18:52:00.664579 kernel: CPU topo: Max. logical dies: 1 May 22 18:52:00.664590 kernel: CPU topo: Max. dies per package: 1 May 22 18:52:00.664597 kernel: CPU topo: Max. threads per core: 2 May 22 18:52:00.664606 kernel: CPU topo: Num. cores per package: 1 May 22 18:52:00.664614 kernel: CPU topo: Num. threads per package: 2 May 22 18:52:00.664622 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs May 22 18:52:00.664636 kernel: [mem 0x40000000-0xffffffff] available for PCI devices May 22 18:52:00.664651 kernel: Booting paravirtualized kernel on Hyper-V May 22 18:52:00.664675 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns May 22 18:52:00.664691 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 May 22 18:52:00.664699 kernel: percpu: Embedded 60 pages/cpu s208408 r8192 d29160 u1048576 May 22 18:52:00.664708 kernel: pcpu-alloc: s208408 r8192 d29160 u1048576 alloc=1*2097152 May 22 18:52:00.664725 kernel: pcpu-alloc: [0] 0 1 May 22 18:52:00.664738 kernel: Hyper-V: PV spinlocks enabled May 22 18:52:00.664749 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) May 22 18:52:00.664763 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=tty1 console=ttyS0,115200n8 earlyprintk=ttyS0,115200 flatcar.first_boot=detected flatcar.oem.id=azure flatcar.autologin verity.usrhash=52c0da84a3f2e3835ffa746c8f820a8956b2e6f69edb5b3b2e9f90b6eb0ea633 May 22 18:52:00.664775 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) May 22 18:52:00.664783 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 22 18:52:00.664790 kernel: Fallback order for Node 0: 0 May 22 18:52:00.664797 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2095807 May 22 18:52:00.664808 kernel: Policy zone: Normal May 22 18:52:00.664816 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 22 18:52:00.664826 kernel: software IO TLB: area num 2. May 22 18:52:00.664834 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 May 22 18:52:00.664842 kernel: ftrace: allocating 41958 entries in 164 pages May 22 18:52:00.664850 kernel: ftrace: allocated 164 pages with 3 groups May 22 18:52:00.664858 kernel: Dynamic Preempt: voluntary May 22 18:52:00.664866 kernel: rcu: Preemptible hierarchical RCU implementation. May 22 18:52:00.664878 kernel: rcu: RCU event tracing is enabled. May 22 18:52:00.664895 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. May 22 18:52:00.664904 kernel: Trampoline variant of Tasks RCU enabled. May 22 18:52:00.664914 kernel: Rude variant of Tasks RCU enabled. May 22 18:52:00.664922 kernel: Tracing variant of Tasks RCU enabled. May 22 18:52:00.664931 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 22 18:52:00.664940 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 May 22 18:52:00.664949 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 22 18:52:00.664958 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 22 18:52:00.664969 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 22 18:52:00.664979 kernel: Using NULL legacy PIC May 22 18:52:00.664988 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0 May 22 18:52:00.664996 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 22 18:52:00.665004 kernel: Console: colour dummy device 80x25 May 22 18:52:00.665015 kernel: printk: legacy console [tty1] enabled May 22 18:52:00.665026 kernel: printk: legacy console [ttyS0] enabled May 22 18:52:00.665035 kernel: printk: legacy bootconsole [earlyser0] disabled May 22 18:52:00.665044 kernel: ACPI: Core revision 20240827 May 22 18:52:00.665053 kernel: Failed to register legacy timer interrupt May 22 18:52:00.665062 kernel: APIC: Switch to symmetric I/O mode setup May 22 18:52:00.665076 kernel: x2apic enabled May 22 18:52:00.665087 kernel: APIC: Switched APIC routing to: physical x2apic May 22 18:52:00.665096 kernel: Hyper-V: Host Build 10.0.26102.1310-1-0 May 22 18:52:00.665105 kernel: Hyper-V: enabling crash_kexec_post_notifiers May 22 18:52:00.665113 kernel: Hyper-V: Disabling IBT because of Hyper-V bug May 22 18:52:00.665121 kernel: Hyper-V: Using IPI hypercalls May 22 18:52:00.665130 kernel: APIC: send_IPI() replaced with hv_send_ipi() May 22 18:52:00.665141 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() May 22 18:52:00.665150 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() May 22 18:52:00.665161 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() May 22 18:52:00.665172 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() May 22 18:52:00.665180 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() May 22 18:52:00.665192 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212735f0517, max_idle_ns: 440795237604 ns May 22 18:52:00.665201 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4600.00 BogoMIPS (lpj=2300001) May 22 18:52:00.665213 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated May 22 18:52:00.665224 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 May 22 18:52:00.665232 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 May 22 18:52:00.665240 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization May 22 18:52:00.665249 kernel: Spectre V2 : Mitigation: Retpolines May 22 18:52:00.665261 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT May 22 18:52:00.665270 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! May 22 18:52:00.665279 kernel: RETBleed: Vulnerable May 22 18:52:00.665289 kernel: Speculative Store Bypass: Vulnerable May 22 18:52:00.665298 kernel: active return thunk: its_return_thunk May 22 18:52:00.665307 kernel: ITS: Mitigation: Aligned branch/return thunks May 22 18:52:00.665318 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' May 22 18:52:00.665326 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' May 22 18:52:00.665335 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' May 22 18:52:00.665344 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' May 22 18:52:00.665353 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' May 22 18:52:00.665362 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' May 22 18:52:00.665370 kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' May 22 18:52:00.665600 kernel: x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' May 22 18:52:00.665611 kernel: x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' May 22 18:52:00.665619 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 May 22 18:52:00.665630 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 May 22 18:52:00.665639 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 May 22 18:52:00.665648 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 May 22 18:52:00.665670 kernel: x86/fpu: xstate_offset[11]: 2432, xstate_sizes[11]: 16 May 22 18:52:00.665680 kernel: x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 May 22 18:52:00.665689 kernel: x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 May 22 18:52:00.665698 kernel: x86/fpu: Enabled xstate features 0x608e7, context size is 10752 bytes, using 'compacted' format. May 22 18:52:00.665707 kernel: Freeing SMP alternatives memory: 36K May 22 18:52:00.665715 kernel: pid_max: default: 32768 minimum: 301 May 22 18:52:00.665724 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima May 22 18:52:00.665732 kernel: landlock: Up and running. May 22 18:52:00.665743 kernel: SELinux: Initializing. May 22 18:52:00.665751 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) May 22 18:52:00.665757 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) May 22 18:52:00.665763 kernel: smpboot: CPU0: Intel INTEL(R) XEON(R) PLATINUM 8573C (family: 0x6, model: 0xcf, stepping: 0x2) May 22 18:52:00.665769 kernel: Performance Events: unsupported p6 CPU model 207 no PMU driver, software events only. May 22 18:52:00.665776 kernel: signal: max sigframe size: 11952 May 22 18:52:00.665782 kernel: rcu: Hierarchical SRCU implementation. May 22 18:52:00.665791 kernel: rcu: Max phase no-delay instances is 400. May 22 18:52:00.665799 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level May 22 18:52:00.665805 kernel: NMI watchdog: Perf NMI watchdog permanently disabled May 22 18:52:00.665812 kernel: smp: Bringing up secondary CPUs ... May 22 18:52:00.665822 kernel: smpboot: x86: Booting SMP configuration: May 22 18:52:00.665829 kernel: .... node #0, CPUs: #1 May 22 18:52:00.665837 kernel: smp: Brought up 1 node, 2 CPUs May 22 18:52:00.665843 kernel: smpboot: Total of 2 processors activated (9200.00 BogoMIPS) May 22 18:52:00.665850 kernel: Memory: 8058740K/8383228K available (14336K kernel code, 2475K rwdata, 32160K rodata, 15988K init, 2068K bss, 318228K reserved, 0K cma-reserved) May 22 18:52:00.665858 kernel: devtmpfs: initialized May 22 18:52:00.665864 kernel: x86/mm: Memory block size: 128MB May 22 18:52:00.665870 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) May 22 18:52:00.665877 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 22 18:52:00.665883 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) May 22 18:52:00.665889 kernel: pinctrl core: initialized pinctrl subsystem May 22 18:52:00.665895 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 22 18:52:00.665905 kernel: audit: initializing netlink subsys (disabled) May 22 18:52:00.665911 kernel: audit: type=2000 audit(1779475914.070:1): state=initialized audit_enabled=0 res=1 May 22 18:52:00.665917 kernel: thermal_sys: Registered thermal governor 'step_wise' May 22 18:52:00.665923 kernel: thermal_sys: Registered thermal governor 'user_space' May 22 18:52:00.665930 kernel: cpuidle: using governor menu May 22 18:52:00.665936 kernel: efi: Freeing EFI boot services memory: 34628K May 22 18:52:00.665942 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 22 18:52:00.665950 kernel: dca service started, version 1.12.1 May 22 18:52:00.665958 kernel: e820: reserve RAM buffer [mem 0x044fe000-0x07ffffff] May 22 18:52:00.665964 kernel: e820: reserve RAM buffer [mem 0x3ff1f000-0x3fffffff] May 22 18:52:00.665970 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 22 18:52:00.665979 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 22 18:52:00.665985 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page May 22 18:52:00.665991 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 22 18:52:00.665999 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page May 22 18:52:00.666005 kernel: ACPI: Added _OSI(Module Device) May 22 18:52:00.666011 kernel: ACPI: Added _OSI(Processor Device) May 22 18:52:00.666017 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 22 18:52:00.666023 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 22 18:52:00.666029 kernel: ACPI: Interpreter enabled May 22 18:52:00.666035 kernel: ACPI: PM: (supports S0 S5) May 22 18:52:00.666043 kernel: ACPI: Using IOAPIC for interrupt routing May 22 18:52:00.666049 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug May 22 18:52:00.666055 kernel: PCI: Ignoring E820 reservations for host bridge windows May 22 18:52:00.666061 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F May 22 18:52:00.666067 kernel: iommu: Default domain type: Translated May 22 18:52:00.666073 kernel: iommu: DMA domain TLB invalidation policy: lazy mode May 22 18:52:00.666079 kernel: efivars: Registered efivars operations May 22 18:52:00.666087 kernel: PCI: Using ACPI for IRQ routing May 22 18:52:00.666093 kernel: PCI: System does not support PCI May 22 18:52:00.666099 kernel: vgaarb: loaded May 22 18:52:00.666105 kernel: clocksource: Switched to clocksource tsc-early May 22 18:52:00.666111 kernel: VFS: Disk quotas dquot_6.6.0 May 22 18:52:00.666117 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 22 18:52:00.666123 kernel: pnp: PnP ACPI init May 22 18:52:00.666131 kernel: pnp: PnP ACPI: found 3 devices May 22 18:52:00.666137 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns May 22 18:52:00.666143 kernel: NET: Registered PF_INET protocol family May 22 18:52:00.666149 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) May 22 18:52:00.666156 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) May 22 18:52:00.666162 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 22 18:52:00.666168 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) May 22 18:52:00.666175 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) May 22 18:52:00.666182 kernel: TCP: Hash tables configured (established 65536 bind 65536) May 22 18:52:00.666188 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) May 22 18:52:00.666194 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) May 22 18:52:00.666200 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 22 18:52:00.666206 kernel: NET: Registered PF_XDP protocol family May 22 18:52:00.666212 kernel: PCI: CLS 0 bytes, default 64 May 22 18:52:00.666220 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) May 22 18:52:00.666226 kernel: software IO TLB: mapped [mem 0x000000003a9aa000-0x000000003e9aa000] (64MB) May 22 18:52:00.666232 kernel: RAPL PMU: API unit is 2^-32 Joules, 1 fixed counters, 10737418240 ms ovfl timer May 22 18:52:00.666238 kernel: RAPL PMU: hw unit of domain psys 2^-0 Joules May 22 18:52:00.666245 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212735f0517, max_idle_ns: 440795237604 ns May 22 18:52:00.666251 kernel: clocksource: Switched to clocksource tsc May 22 18:52:00.666257 kernel: Initialise system trusted keyrings May 22 18:52:00.666265 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 May 22 18:52:00.666272 kernel: Key type asymmetric registered May 22 18:52:00.666278 kernel: Asymmetric key parser 'x509' registered May 22 18:52:00.666284 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 22 18:52:00.666290 kernel: io scheduler mq-deadline registered May 22 18:52:00.666296 kernel: io scheduler kyber registered May 22 18:52:00.666302 kernel: io scheduler bfq registered May 22 18:52:00.666308 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 May 22 18:52:00.666316 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 22 18:52:00.666322 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A May 22 18:52:00.666328 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A May 22 18:52:00.666334 kernel: serial8250: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A May 22 18:52:00.666340 kernel: ACPI: bus type drm_connector registered May 22 18:52:00.666346 kernel: i8042: PNP: No PS/2 controller found. May 22 18:52:00.666498 kernel: rtc_cmos 00:02: registered as rtc0 May 22 18:52:00.666595 kernel: rtc_cmos 00:02: setting system clock to 2026-05-22T18:51:56 UTC (1779475916) May 22 18:52:00.666712 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram May 22 18:52:00.666725 kernel: intel_pstate: Intel P-state driver initializing May 22 18:52:00.666735 kernel: efifb: probing for efifb May 22 18:52:00.666744 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k May 22 18:52:00.666756 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 May 22 18:52:00.666765 kernel: efifb: scrolling: redraw May 22 18:52:00.666774 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 May 22 18:52:00.666784 kernel: Console: switching to colour frame buffer device 128x48 May 22 18:52:00.666794 kernel: fb0: EFI VGA frame buffer device May 22 18:52:00.666804 kernel: pstore: Using crash dump compression: deflate May 22 18:52:00.666813 kernel: pstore: Registered efi_pstore as persistent store backend May 22 18:52:00.666823 kernel: NET: Registered PF_INET6 protocol family May 22 18:52:00.666834 kernel: Segment Routing with IPv6 May 22 18:52:00.666843 kernel: In-situ OAM (IOAM) with IPv6 May 22 18:52:00.666852 kernel: NET: Registered PF_PACKET protocol family May 22 18:52:00.666861 kernel: Key type dns_resolver registered May 22 18:52:00.666870 kernel: IPI shorthand broadcast: enabled May 22 18:52:00.666880 kernel: sched_clock: Marking stable (1999004242, 94201358)->(2454450989, -361245389) May 22 18:52:00.666889 kernel: registered taskstats version 1 May 22 18:52:00.666900 kernel: Loading compiled-in X.509 certificates May 22 18:52:00.666909 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.90-flatcar: 84c66e33e90bd2c3a833720e1054371cb72bb7d1' May 22 18:52:00.666919 kernel: Demotion targets for Node 0: null May 22 18:52:00.666928 kernel: Key type .fscrypt registered May 22 18:52:00.666937 kernel: Key type fscrypt-provisioning registered May 22 18:52:00.666948 kernel: ima: No TPM chip found, activating TPM-bypass! May 22 18:52:00.666958 kernel: ima: Allocated hash algorithm: sha1 May 22 18:52:00.666969 kernel: ima: No architecture policies found May 22 18:52:00.666979 kernel: clk: Disabling unused clocks May 22 18:52:00.666989 kernel: Freeing unused kernel image (initmem) memory: 15988K May 22 18:52:00.666999 kernel: Write protecting the kernel read-only data: 47104k May 22 18:52:00.667008 kernel: Freeing unused kernel image (rodata/data gap) memory: 608K May 22 18:52:00.667017 kernel: Run /init as init process May 22 18:52:00.667027 kernel: with arguments: May 22 18:52:00.667038 kernel: /init May 22 18:52:00.667047 kernel: with environment: May 22 18:52:00.667057 kernel: HOME=/ May 22 18:52:00.667066 kernel: TERM=linux May 22 18:52:00.667075 kernel: hv_vmbus: Vmbus version:5.3 May 22 18:52:00.667085 kernel: pps_core: LinuxPPS API ver. 1 registered May 22 18:52:00.667095 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti May 22 18:52:00.667105 kernel: PTP clock support registered May 22 18:52:00.667116 kernel: hv_utils: Registering HyperV Utility Driver May 22 18:52:00.667126 kernel: hv_vmbus: registering driver hv_utils May 22 18:52:00.667136 kernel: hv_utils: Shutdown IC version 3.2 May 22 18:52:00.667146 kernel: hv_utils: TimeSync IC version 4.0 May 22 18:52:00.667155 kernel: hv_utils: Heartbeat IC version 3.0 May 22 18:52:00.667165 kernel: SCSI subsystem initialized May 22 18:52:00.667175 kernel: hv_vmbus: registering driver hv_pci May 22 18:52:00.667361 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI VMBus probing: Using version 0x10004 May 22 18:52:00.667511 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI host bridge to bus c05b:00 May 22 18:52:00.667699 kernel: pci_bus c05b:00: root bus resource [mem 0xfc0000000-0xfc007ffff window] May 22 18:52:00.667844 kernel: pci_bus c05b:00: No busn resource found for root bus, will use [bus 00-ff] May 22 18:52:00.668540 kernel: pci c05b:00:00.0: [1414:00a9] type 00 class 0x010802 PCIe Endpoint May 22 18:52:00.669109 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit] May 22 18:52:00.669297 kernel: pci_bus c05b:00: busn_res: [bus 00-ff] end is updated to 00 May 22 18:52:00.669477 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit]: assigned May 22 18:52:00.669488 kernel: hv_vmbus: registering driver hv_storvsc May 22 18:52:00.669685 kernel: scsi host0: storvsc_host_t May 22 18:52:00.669862 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 May 22 18:52:00.669876 kernel: hid: raw HID events driver (C) Jiri Kosina May 22 18:52:00.669886 kernel: hv_vmbus: registering driver hid_hyperv May 22 18:52:00.669896 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 May 22 18:52:00.670039 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on May 22 18:52:00.670052 kernel: hv_vmbus: registering driver hyperv_keyboard May 22 18:52:00.670065 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 May 22 18:52:00.670216 kernel: nvme nvme0: pci function c05b:00:00.0 May 22 18:52:00.670400 kernel: nvme c05b:00:00.0: enabling device (0000 -> 0002) May 22 18:52:00.670534 kernel: nvme nvme0: 2/0/0 default/read/poll queues May 22 18:52:00.670547 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 22 18:52:00.670726 kernel: sr 0:0:0:2: [sr0] scsi-1 drive May 22 18:52:00.670741 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 May 22 18:52:00.673076 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 May 22 18:52:00.673099 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 22 18:52:00.673107 kernel: device-mapper: uevent: version 1.0.3 May 22 18:52:00.673129 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev May 22 18:52:00.673137 kernel: device-mapper: verity: sha256 using shash "sha256-generic" May 22 18:52:00.673145 kernel: raid6: avx512x4 gen() 45111 MB/s May 22 18:52:00.673152 kernel: raid6: avx512x2 gen() 45265 MB/s May 22 18:52:00.673158 kernel: raid6: avx512x1 gen() 26062 MB/s May 22 18:52:00.673164 kernel: raid6: avx2x4 gen() 38434 MB/s May 22 18:52:00.673171 kernel: raid6: avx2x2 gen() 40062 MB/s May 22 18:52:00.673177 kernel: raid6: avx2x1 gen() 30691 MB/s May 22 18:52:00.673183 kernel: raid6: using algorithm avx512x2 gen() 45265 MB/s May 22 18:52:00.673190 kernel: raid6: .... xor() 30049 MB/s, rmw enabled May 22 18:52:00.673198 kernel: raid6: using avx512x2 recovery algorithm May 22 18:52:00.673204 kernel: xor: automatically using best checksumming function avx May 22 18:52:00.673210 kernel: Btrfs loaded, zoned=no, fsverity=no May 22 18:52:00.673217 kernel: BTRFS: device fsid 994ff57d-783d-4a21-97d1-907bbd4728b4 devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (945) May 22 18:52:00.673223 kernel: BTRFS info (device dm-0): first mount of filesystem 994ff57d-783d-4a21-97d1-907bbd4728b4 May 22 18:52:00.673230 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm May 22 18:52:00.673237 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations May 22 18:52:00.673244 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time May 22 18:52:00.673251 kernel: BTRFS info (device dm-0 state E): enabling free space tree May 22 18:52:00.673257 kernel: loop: module loaded May 22 18:52:00.673263 kernel: loop0: detected capacity change from 0 to 107200 May 22 18:52:00.673270 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 22 18:52:00.673277 systemd[1]: /etc/systemd/system.conf.d/nocgroup.conf:2: Support for option DefaultCPUAccounting= has been removed and it is ignored May 22 18:52:00.673289 systemd[1]: /etc/systemd/system.conf.d/nocgroup.conf:5: Support for option DefaultBlockIOAccounting= has been removed and it is ignored May 22 18:52:00.673296 systemd[1]: Successfully made /usr/ read-only. May 22 18:52:00.673303 systemd[1]: systemd 258.3 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 22 18:52:00.673310 systemd[1]: Detected virtualization microsoft. May 22 18:52:00.673317 systemd[1]: Detected architecture x86-64. May 22 18:52:00.673324 systemd[1]: Running in initrd. May 22 18:52:00.673332 systemd[1]: Initializing machine ID from random generator. May 22 18:52:00.673339 systemd[1]: No hostname configured, using default hostname. May 22 18:52:00.673346 systemd[1]: Hostname set to . May 22 18:52:00.673352 systemd[1]: Queued start job for default target initrd.target. May 22 18:52:00.673362 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. May 22 18:52:00.673369 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 22 18:52:00.673376 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 22 18:52:00.673384 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 22 18:52:00.673391 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 22 18:52:00.673398 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 22 18:52:00.673406 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 22 18:52:00.673413 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 22 18:52:00.673420 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 22 18:52:00.673426 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. May 22 18:52:00.673433 systemd[1]: Reached target paths.target - Path Units. May 22 18:52:00.673440 systemd[1]: Reached target slices.target - Slice Units. May 22 18:52:00.673448 systemd[1]: Reached target swap.target - Swaps. May 22 18:52:00.673454 systemd[1]: Reached target timers.target - Timer Units. May 22 18:52:00.673461 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 22 18:52:00.673468 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 22 18:52:00.673474 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. May 22 18:52:00.673481 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 22 18:52:00.673488 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 22 18:52:00.673496 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 22 18:52:00.673503 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 22 18:52:00.673510 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 22 18:52:00.673517 systemd[1]: Reached target sockets.target - Socket Units. May 22 18:52:00.673524 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 22 18:52:00.673531 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 22 18:52:00.673537 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 22 18:52:00.673545 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 22 18:52:00.673552 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). May 22 18:52:00.673559 systemd[1]: Starting systemd-fsck-usr.service... May 22 18:52:00.673566 systemd[1]: Starting systemd-journald.service - Journal Service... May 22 18:52:00.673574 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 22 18:52:00.673581 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:52:00.673588 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 22 18:52:00.673594 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 22 18:52:00.673601 systemd[1]: Finished systemd-fsck-usr.service. May 22 18:52:00.673629 systemd-journald[1080]: Collecting audit messages is enabled. May 22 18:52:00.673648 kernel: audit: type=1130 audit(1779475920.658:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.673669 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 22 18:52:00.673698 systemd-journald[1080]: Journal started May 22 18:52:00.673720 systemd-journald[1080]: Runtime Journal (/run/log/journal/0ec54793dfe14c9580533ca3d416b28c) is 8M, max 158.5M, 150.5M free. May 22 18:52:00.658000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.677717 systemd[1]: Started systemd-journald.service - Journal Service. May 22 18:52:00.677000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.682706 kernel: audit: type=1130 audit(1779475920.677:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.682845 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 22 18:52:00.751397 systemd-tmpfiles[1092]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. May 22 18:52:00.752804 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 22 18:52:00.751000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.758707 kernel: audit: type=1130 audit(1779475920.751:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.763629 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 22 18:52:00.765742 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 22 18:52:00.764000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.769676 kernel: audit: type=1130 audit(1779475920.764:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.788765 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 22 18:52:00.787000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.792679 kernel: audit: type=1130 audit(1779475920.787:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.797675 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 22 18:52:00.809878 systemd-modules-load[1082]: Inserted module 'br_netfilter' May 22 18:52:00.809000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.812278 kernel: Bridge firewalling registered May 22 18:52:00.810546 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 22 18:52:00.815755 kernel: audit: type=1130 audit(1779475920.809:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.817210 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 22 18:52:00.887741 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:52:00.890000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.895990 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 22 18:52:00.898754 kernel: audit: type=1130 audit(1779475920.890:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.898000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.901162 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 22 18:52:00.907117 kernel: audit: type=1130 audit(1779475920.898:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.907000 audit: BPF prog-id=5 op=LOAD May 22 18:52:00.910688 kernel: audit: type=1334 audit(1779475920.907:10): prog-id=5 op=LOAD May 22 18:52:00.912239 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 22 18:52:00.930098 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 22 18:52:00.932000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.940864 kernel: audit: type=1130 audit(1779475920.932:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:00.939154 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 22 18:52:01.053241 dracut-cmdline[1119]: dracut-109 May 22 18:52:01.054954 systemd-resolved[1107]: Positive Trust Anchors: May 22 18:52:01.054960 systemd-resolved[1107]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 22 18:52:01.054963 systemd-resolved[1107]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 May 22 18:52:01.054991 systemd-resolved[1107]: 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 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test May 22 18:52:01.104169 dracut-cmdline[1119]: Using kernel command line parameters: SYSTEMD_SULOGIN_FORCE=1 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=tty1 console=ttyS0,115200n8 earlyprintk=ttyS0,115200 flatcar.first_boot=detected flatcar.oem.id=azure flatcar.autologin verity.usrhash=52c0da84a3f2e3835ffa746c8f820a8956b2e6f69edb5b3b2e9f90b6eb0ea633 May 22 18:52:01.117294 systemd-resolved[1107]: Defaulting to hostname 'linux'. May 22 18:52:01.121032 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 22 18:52:01.122000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:01.124612 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 22 18:52:01.208676 kernel: Loading iSCSI transport class v2.0-870. May 22 18:52:01.267681 kernel: iscsi: registered transport (tcp) May 22 18:52:01.344030 kernel: iscsi: registered transport (qla4xxx) May 22 18:52:01.344102 kernel: QLogic iSCSI HBA Driver May 22 18:52:01.515608 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... May 22 18:52:01.533528 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. May 22 18:52:01.535000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:01.538250 systemd[1]: Reached target network-pre.target - Preparation for Network. May 22 18:52:01.571441 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 22 18:52:01.570000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:01.574932 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 22 18:52:01.594835 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 22 18:52:01.618043 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 22 18:52:01.621000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:01.621000 audit: BPF prog-id=6 op=LOAD May 22 18:52:01.621000 audit: BPF prog-id=7 op=LOAD May 22 18:52:01.623707 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 22 18:52:01.672883 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 22 18:52:01.675000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:01.675756 systemd-udevd[1360]: Using default interface naming scheme 'v258'. May 22 18:52:01.777307 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 22 18:52:01.782000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:01.787594 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 22 18:52:01.789000 audit: BPF prog-id=8 op=LOAD May 22 18:52:01.793326 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 22 18:52:01.816553 dracut-pre-trigger[1460]: rd.md=0: removing MD RAID activation May 22 18:52:01.842813 systemd-networkd[1465]: lo: Link UP May 22 18:52:01.842822 systemd-networkd[1465]: lo: Gained carrier May 22 18:52:01.847000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:01.844680 systemd[1]: Started systemd-networkd.service - Network Configuration. May 22 18:52:01.850000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:01.848366 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 22 18:52:01.852644 systemd[1]: Reached target network.target - Network. May 22 18:52:01.857839 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 22 18:52:01.918702 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 22 18:52:01.918000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:01.922485 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 22 18:52:02.019681 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#312 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 May 22 18:52:02.037692 kernel: cryptd: max_cpu_qlen set to 1000 May 22 18:52:02.050854 kernel: hv_vmbus: registering driver hv_netvsc May 22 18:52:02.060157 kernel: hv_netvsc f8615163-0000-1000-2000-6045bdc18de3 (unnamed net_device) (uninitialized): VF slot 1 added May 22 18:52:02.074048 systemd-networkd[1465]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network May 22 18:52:02.074057 systemd-networkd[1465]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 22 18:52:02.077721 systemd-networkd[1465]: eth0: Link UP May 22 18:52:02.079160 systemd-networkd[1465]: eth0: Gained carrier May 22 18:52:02.079174 systemd-networkd[1465]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network May 22 18:52:02.091880 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 22 18:52:02.090000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:02.091998 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:52:02.092560 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:52:02.094755 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:52:02.103761 systemd-networkd[1465]: eth0: DHCPv4 address 10.0.0.23/24, gateway 10.0.0.1 acquired from 168.63.129.16 May 22 18:52:02.118904 kernel: AES CTR mode by8 optimization enabled May 22 18:52:02.144578 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:52:02.147000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:02.261715 kernel: nvme nvme0: using unchecked data buffer May 22 18:52:02.358318 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - MSFT NVMe Accelerator v1.0 USR-A. May 22 18:52:02.363227 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 22 18:52:02.457072 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - MSFT NVMe Accelerator v1.0 EFI-SYSTEM. May 22 18:52:02.497427 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. May 22 18:52:02.514270 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - MSFT NVMe Accelerator v1.0 ROOT. May 22 18:52:02.534826 systemd[1]: Mounting oem.mount - /oem... May 22 18:52:02.583506 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1656) May 22 18:52:02.583605 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem e33db1dc-bf4d-468d-946e-8f4b5a090363 May 22 18:52:02.585212 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm May 22 18:52:02.608029 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 22 18:52:02.607000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:02.610778 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 22 18:52:02.613948 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 22 18:52:02.617158 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 22 18:52:02.621380 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 22 18:52:02.657707 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 22 18:52:02.658000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:02.695671 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations May 22 18:52:02.695707 kernel: BTRFS info (device nvme0n1p6): turning on async discard May 22 18:52:02.695720 kernel: BTRFS info (device nvme0n1p6): enabling free space tree May 22 18:52:02.705655 systemd[1]: Mounted oem.mount - /oem. May 22 18:52:02.709823 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 22 18:52:03.078788 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 May 22 18:52:03.079094 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 May 22 18:52:03.081950 kernel: pci_bus 7870:00: root bus resource [mem 0xfc2000000-0xfc4007fff window] May 22 18:52:03.083483 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] May 22 18:52:03.088856 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint May 22 18:52:03.092705 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref] May 22 18:52:03.097860 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref] May 22 18:52:03.097928 kernel: pci 7870:00:00.0: enabling Extended Tags May 22 18:52:03.114984 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 May 22 18:52:03.115212 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref]: assigned May 22 18:52:03.118829 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref]: assigned May 22 18:52:03.151846 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) May 22 18:52:03.161672 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 May 22 18:52:03.165417 kernel: hv_netvsc f8615163-0000-1000-2000-6045bdc18de3 eth0: VF registering: eth1 May 22 18:52:03.165582 kernel: mana 7870:00:00.0 eth1: joined to eth0 May 22 18:52:03.171684 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 May 22 18:52:03.172022 systemd-networkd[1465]: eth1: Interface name change detected, renamed to enP30832s1. May 22 18:52:03.271677 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 May 22 18:52:03.274672 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 May 22 18:52:03.276609 systemd-networkd[1465]: enP30832s1: Link UP May 22 18:52:03.276950 systemd-networkd[1465]: enP30832s1: Gained carrier May 22 18:52:03.279731 kernel: hv_netvsc f8615163-0000-1000-2000-6045bdc18de3 eth0: Data path switched to VF: enP30832s1 May 22 18:52:03.644808 systemd-networkd[1465]: eth0: Gained IPv6LL May 22 18:52:03.705625 disk-uuid[1641]: Warning: The kernel is still using the old partition table. May 22 18:52:03.705625 disk-uuid[1641]: The new table will be used at the next reboot or after you May 22 18:52:03.705625 disk-uuid[1641]: run partprobe(8) or kpartx(8) May 22 18:52:03.705625 disk-uuid[1641]: The operation has completed successfully. May 22 18:52:03.719503 systemd[1]: disk-uuid.service: Deactivated successfully. May 22 18:52:03.718000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:03.718000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:03.719675 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 22 18:52:04.227754 ignition[1697]: Ignition 2.24.0 May 22 18:52:04.227766 ignition[1697]: Stage: fetch-offline May 22 18:52:04.229413 ignition[1697]: no config dir at "/usr/lib/ignition/base.d" May 22 18:52:04.235000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:04.232133 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 22 18:52:04.229422 ignition[1697]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:52:04.238092 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... May 22 18:52:04.229513 ignition[1697]: parsed url from cmdline: "" May 22 18:52:04.229516 ignition[1697]: no config URL provided May 22 18:52:04.229520 ignition[1697]: reading system config file "/usr/lib/ignition/user.ign" May 22 18:52:04.229539 ignition[1697]: no config at "/usr/lib/ignition/user.ign" May 22 18:52:04.229815 ignition[1697]: failed to fetch config: resource requires networking May 22 18:52:04.230190 ignition[1697]: Ignition finished successfully May 22 18:52:04.267495 ignition[1709]: Ignition 2.24.0 May 22 18:52:04.267507 ignition[1709]: Stage: fetch May 22 18:52:04.267756 ignition[1709]: no config dir at "/usr/lib/ignition/base.d" May 22 18:52:04.267763 ignition[1709]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:52:04.267843 ignition[1709]: parsed url from cmdline: "" May 22 18:52:04.267846 ignition[1709]: no config URL provided May 22 18:52:04.267851 ignition[1709]: reading system config file "/usr/lib/ignition/user.ign" May 22 18:52:04.267858 ignition[1709]: no config at "/usr/lib/ignition/user.ign" May 22 18:52:04.267877 ignition[1709]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 May 22 18:52:04.334800 ignition[1709]: GET result: OK May 22 18:52:04.334841 ignition[1709]: config has been read from IMDS userdata May 22 18:52:04.334852 ignition[1709]: parsing config with SHA512: f82e233423be209b4521363a4130f3c43f404fda0408e7cf35adb776795d3f02ba245f97d943d4d93fc0313ebd6325018bce3081eb32c7278f2ec438179e9fa7 May 22 18:52:04.342424 unknown[1709]: fetched base config from "system" May 22 18:52:04.342434 unknown[1709]: fetched base config from "system" May 22 18:52:04.342685 ignition[1709]: fetch: fetch complete May 22 18:52:04.346000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:04.342439 unknown[1709]: fetched user config from "azure" May 22 18:52:04.342689 ignition[1709]: fetch: fetch passed May 22 18:52:04.345218 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). May 22 18:52:04.342727 ignition[1709]: Ignition finished successfully May 22 18:52:04.349587 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 22 18:52:04.368298 ignition[1715]: Ignition 2.24.0 May 22 18:52:04.368309 ignition[1715]: Stage: kargs May 22 18:52:04.372000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:04.370335 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 22 18:52:04.368497 ignition[1715]: no config dir at "/usr/lib/ignition/base.d" May 22 18:52:04.374546 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 22 18:52:04.368503 ignition[1715]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:52:04.369093 ignition[1715]: kargs: kargs passed May 22 18:52:04.369123 ignition[1715]: Ignition finished successfully May 22 18:52:04.424450 systemd[1]: ignition-kargs.service: Deactivated successfully. May 22 18:52:04.424557 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 22 18:52:04.427000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:04.428939 systemd[1]: ignition-fetch.service: Deactivated successfully. May 22 18:52:04.431000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:04.434000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:04.429056 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). May 22 18:52:04.432864 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 22 18:52:04.432972 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 22 18:52:04.436751 systemd[1]: Unmounting oem.mount - /oem... May 22 18:52:04.453746 systemd[1]: oem.mount: Deactivated successfully. May 22 18:52:04.454884 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem e33db1dc-bf4d-468d-946e-8f4b5a090363 May 22 18:52:04.453862 systemd[1]: Unmounted oem.mount - /oem. May 22 18:52:04.481617 ignition[1725]: Ignition 2.24.0 May 22 18:52:04.481628 ignition[1725]: Stage: disks May 22 18:52:04.481848 ignition[1725]: no config dir at "/usr/lib/ignition/base.d" May 22 18:52:04.485000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:04.483917 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 22 18:52:04.481855 ignition[1725]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:52:04.486953 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 22 18:52:04.482411 ignition[1725]: disks: disks passed May 22 18:52:04.487105 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 22 18:52:04.482443 ignition[1725]: Ignition finished successfully May 22 18:52:04.487130 systemd[1]: Reached target local-fs.target - Local File Systems. May 22 18:52:04.487149 systemd[1]: Reached target sysinit.target - System Initialization. May 22 18:52:04.487620 systemd[1]: Reached target basic.target - Basic System. May 22 18:52:04.489786 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 22 18:52:04.612285 systemd-fsck[1735]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks May 22 18:52:04.616768 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 22 18:52:04.621000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:04.625754 systemd[1]: Mounting sysroot.mount - /sysroot... May 22 18:52:05.019677 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 47741ff1-2f1b-4b93-b3f5-dcc2ee688f01 r/w with ordered data mode. Quota mode: none. May 22 18:52:05.019788 systemd[1]: Mounted sysroot.mount - /sysroot. May 22 18:52:05.024222 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 22 18:52:05.040270 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 22 18:52:05.043835 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... May 22 18:52:05.050065 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 22 18:52:05.050362 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 22 18:52:05.067822 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 22 18:52:05.071491 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 22 18:52:05.736467 coreos-metadata[1745]: May 22 18:52:05.736 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 May 22 18:52:05.738626 coreos-metadata[1745]: May 22 18:52:05.738 INFO Fetch successful May 22 18:52:05.739919 coreos-metadata[1745]: May 22 18:52:05.738 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 May 22 18:52:05.748532 coreos-metadata[1745]: May 22 18:52:05.748 INFO Fetch successful May 22 18:52:05.749918 coreos-metadata[1745]: May 22 18:52:05.748 INFO wrote hostname ci-4694.0.1-a-51b1c0bae6 to /sysroot/etc/hostname May 22 18:52:05.751894 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. May 22 18:52:05.754000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:05.760114 kernel: kauditd_printk_skb: 26 callbacks suppressed May 22 18:52:05.760145 kernel: audit: type=1130 audit(1779475925.754:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:06.744679 kernel: loop1: detected capacity change from 0 to 43464 May 22 18:52:06.833682 kernel: loop1: p1 p2 p3 May 22 18:52:07.500701 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:07.500775 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:07.501885 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:07.503683 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:07.503490 systemd-confext[1829]: device-mapper: reload ioctl on 34c0bb0cf7c56978b902b451b6b90d2903015da37e581b8f5a52ffa1a203cba5-verity (254:1) failed: Invalid argument May 22 18:52:07.540690 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:07.645695 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. May 22 18:52:07.663103 kernel: loop2: detected capacity change from 0 to 43464 May 22 18:52:07.663157 kernel: loop2: p1 p2 p3 May 22 18:52:07.672682 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:07.676340 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:07.676383 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:07.679690 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:07.679271 (sd-merge)[1839]: device-mapper: reload ioctl on 34c0bb0cf7c56978b902b451b6b90d2903015da37e581b8f5a52ffa1a203cba5-verity (254:1) failed: Invalid argument May 22 18:52:07.688682 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:07.704579 (sd-merge)[1839]: Using extensions '00-flatcar-default.raw'. May 22 18:52:07.705411 (sd-merge)[1839]: Merged extensions into '/sysroot/etc'. May 22 18:52:07.709235 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. May 22 18:52:07.711515 initrd-setup-root[1846]: /etc 00-flatcar-default Fri 2026-05-22 18:52:00 UTC May 22 18:52:07.712813 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 22 18:52:07.715000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.719963 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 22 18:52:07.721955 kernel: audit: type=1130 audit(1779475927.715:39): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.731787 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 22 18:52:07.758471 ignition[1851]: INFO : Ignition 2.24.0 May 22 18:52:07.758471 ignition[1851]: INFO : Stage: mount May 22 18:52:07.758471 ignition[1851]: INFO : no config dir at "/usr/lib/ignition/base.d" May 22 18:52:07.758471 ignition[1851]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:52:07.758471 ignition[1851]: INFO : mount: mount passed May 22 18:52:07.766000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.771110 ignition[1851]: INFO : Ignition finished successfully May 22 18:52:07.763916 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 22 18:52:07.779684 kernel: audit: type=1130 audit(1779475927.766:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.773746 systemd[1]: Starting ignition-files.service - Ignition (files)... May 22 18:52:07.781918 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 22 18:52:07.782000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.788727 kernel: audit: type=1130 audit(1779475927.782:41): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.792039 systemd[1]: Mounting oem.mount - /oem... May 22 18:52:07.807674 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1863) May 22 18:52:07.809992 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem e33db1dc-bf4d-468d-946e-8f4b5a090363 May 22 18:52:07.810033 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm May 22 18:52:07.815713 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations May 22 18:52:07.815753 kernel: BTRFS info (device nvme0n1p6): turning on async discard May 22 18:52:07.816980 kernel: BTRFS info (device nvme0n1p6): enabling free space tree May 22 18:52:07.818966 systemd[1]: Mounted oem.mount - /oem. May 22 18:52:07.821933 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 22 18:52:07.834630 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 22 18:52:07.859987 ignition[1882]: INFO : Ignition 2.24.0 May 22 18:52:07.859987 ignition[1882]: INFO : Stage: files May 22 18:52:07.863695 ignition[1882]: INFO : no config dir at "/usr/lib/ignition/base.d" May 22 18:52:07.863695 ignition[1882]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:52:07.863695 ignition[1882]: DEBUG : files: compiled without relabeling support, skipping May 22 18:52:07.876513 ignition[1882]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 22 18:52:07.876513 ignition[1882]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 22 18:52:07.884782 ignition[1882]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 22 18:52:07.884782 ignition[1882]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 22 18:52:07.884782 ignition[1882]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 22 18:52:07.884782 ignition[1882]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/exports" May 22 18:52:07.884782 ignition[1882]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/exports" May 22 18:52:07.884782 ignition[1882]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" May 22 18:52:07.884782 ignition[1882]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 22 18:52:07.884782 ignition[1882]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/var/lib/nfs/etab" May 22 18:52:07.884782 ignition[1882]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/var/lib/nfs/etab" May 22 18:52:07.884782 ignition[1882]: INFO : files: op(6): [started] processing unit "nfs-server.service" May 22 18:52:07.884782 ignition[1882]: INFO : files: op(6): [finished] processing unit "nfs-server.service" May 22 18:52:07.884782 ignition[1882]: INFO : files: op(7): [started] setting preset to enabled for "nfs-server.service" May 22 18:52:07.884782 ignition[1882]: INFO : files: op(7): [finished] setting preset to enabled for "nfs-server.service" May 22 18:52:07.884782 ignition[1882]: INFO : files: createResultFile: createFiles: op(8): [started] writing file "/sysroot/etc/.ignition-result.json" May 22 18:52:07.884782 ignition[1882]: INFO : files: createResultFile: createFiles: op(8): [finished] writing file "/sysroot/etc/.ignition-result.json" May 22 18:52:07.884782 ignition[1882]: INFO : files: files passed May 22 18:52:07.884782 ignition[1882]: INFO : Ignition finished successfully May 22 18:52:07.885000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.881284 unknown[1882]: wrote ssh authorized keys file for user: core May 22 18:52:07.915456 kernel: audit: type=1130 audit(1779475927.885:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.883568 systemd[1]: Finished ignition-files.service - Ignition (files). May 22 18:52:07.888314 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 22 18:52:07.902817 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 22 18:52:07.913013 systemd[1]: ignition-quench.service: Deactivated successfully. May 22 18:52:07.914000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.913105 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 22 18:52:07.914000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.952097 kernel: audit: type=1130 audit(1779475927.914:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.952113 kernel: audit: type=1131 audit(1779475927.914:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:07.978843 initrd-setup-root-after-ignition[1915]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 22 18:52:07.981375 initrd-setup-root-after-ignition[1919]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 22 18:52:07.984764 initrd-setup-root-after-ignition[1915]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 22 18:52:07.989672 kernel: loop3: detected capacity change from 0 to 43464 May 22 18:52:07.992681 kernel: loop3: p1 p2 p3 May 22 18:52:08.004764 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:08.005100 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:08.006926 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:08.008743 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:08.009339 systemd-confext[1921]: device-mapper: reload ioctl on loop3p1-verity (254:2) failed: Invalid argument May 22 18:52:08.017916 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:08.034672 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. May 22 18:52:08.057674 kernel: loop4: detected capacity change from 0 to 43464 May 22 18:52:08.059679 kernel: loop4: p1 p2 p3 May 22 18:52:08.066311 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:08.066346 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:08.067718 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:08.068911 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:08.068968 (sd-merge)[1929]: device-mapper: reload ioctl on loop4p1-verity (254:2) failed: Invalid argument May 22 18:52:08.073109 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:08.090881 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. May 22 18:52:08.090782 (sd-merge)[1929]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. May 22 18:52:08.159677 kernel: loop4: detected capacity change from 0 to 378016 May 22 18:52:08.253065 kernel: loop4: p1 p2 p3 May 22 18:52:09.391776 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:09.391841 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:09.391854 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:09.394561 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:09.395225 systemd-sysext[1937]: device-mapper: reload ioctl on 95e1797b1c18833e5778f5d77b5f1ee1782531a60657be5a26ef59522d21e1dc-verity (254:2) failed: Invalid argument May 22 18:52:09.402699 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:09.665728 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. May 22 18:52:09.846687 kernel: loop5: detected capacity change from 0 to 178200 May 22 18:52:09.914706 kernel: loop5: p1 p2 p3 May 22 18:52:10.339693 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:10.339764 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:10.340945 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:10.342027 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:10.342472 systemd-sysext[1937]: device-mapper: reload ioctl on 76e564ce832c92102e0654503bbfd4392ed6cbfef96de72cad1d345713379e94-verity (254:2) failed: Invalid argument May 22 18:52:10.347755 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:10.435675 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. May 22 18:52:10.490680 kernel: loop6: detected capacity change from 0 to 136912 May 22 18:52:10.506706 kernel: loop6: p1 p2 p3 May 22 18:52:10.839935 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:10.840001 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:10.840022 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:10.841134 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:10.841583 systemd-sysext[1937]: device-mapper: reload ioctl on 13729d316cd67e1d034d8331f36a5bad38437e7a747108afcb7e4d2c7a932a72-verity (254:2) failed: Invalid argument May 22 18:52:10.850818 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:10.931686 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. May 22 18:52:10.952807 kernel: loop7: detected capacity change from 0 to 378016 May 22 18:52:10.952857 kernel: loop7: p1 p2 p3 May 22 18:52:10.980007 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:10.980063 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:10.984524 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:10.985720 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:10.986182 (sd-merge)[1960]: device-mapper: reload ioctl on 95e1797b1c18833e5778f5d77b5f1ee1782531a60657be5a26ef59522d21e1dc-verity (254:2) failed: Invalid argument May 22 18:52:10.992803 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:11.043686 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. May 22 18:52:11.046671 kernel: loop1: detected capacity change from 0 to 178200 May 22 18:52:11.048681 kernel: loop1: p1 p2 p3 May 22 18:52:11.060099 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:11.060199 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:11.062466 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:11.064505 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:11.064952 (sd-merge)[1960]: device-mapper: reload ioctl on 76e564ce832c92102e0654503bbfd4392ed6cbfef96de72cad1d345713379e94-verity (254:3) failed: Invalid argument May 22 18:52:11.073571 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:11.098709 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. May 22 18:52:11.101685 kernel: loop3: detected capacity change from 0 to 136912 May 22 18:52:11.102674 kernel: loop3: p1 p2 p3 May 22 18:52:11.112672 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:11.112708 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:11.114329 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:11.116013 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:11.116027 (sd-merge)[1960]: device-mapper: reload ioctl on 13729d316cd67e1d034d8331f36a5bad38437e7a747108afcb7e4d2c7a932a72-verity (254:4) failed: Invalid argument May 22 18:52:11.120770 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:11.153493 (sd-merge)[1960]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4694.0.1.raw'. May 22 18:52:11.156471 (sd-merge)[1960]: Merged extensions into '/sysroot/usr'. May 22 18:52:11.159535 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. May 22 18:52:11.160048 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 22 18:52:11.164802 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 22 18:52:11.160000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.174524 kernel: audit: type=1130 audit(1779475931.160:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.183619 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 22 18:52:11.183747 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 22 18:52:11.187000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.188197 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. May 22 18:52:11.187000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.197802 kernel: audit: type=1130 audit(1779475931.187:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.188530 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 22 18:52:11.200097 kernel: audit: type=1131 audit(1779475931.187:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.194770 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 22 18:52:11.196711 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 22 18:52:11.214814 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 22 18:52:11.213000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.223010 kernel: audit: type=1130 audit(1779475931.213:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.220420 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 22 18:52:11.234184 systemd[1]: Stopped target basic.target - Basic System. May 22 18:52:11.234351 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 22 18:52:11.234606 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 22 18:52:11.241837 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. May 22 18:52:11.245817 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 22 18:52:11.249813 systemd[1]: Stopped target paths.target - Path Units. May 22 18:52:11.254802 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 22 18:52:11.258607 systemd[1]: Stopped target slices.target - Slice Units. May 22 18:52:11.259249 systemd[1]: Stopped target sockets.target - Socket Units. May 22 18:52:11.259517 systemd[1]: Stopped target sysinit.target - System Initialization. May 22 18:52:11.266467 systemd[1]: Stopped target local-fs.target - Local File Systems. May 22 18:52:11.272850 systemd[1]: Stopped target swap.target - Swaps. May 22 18:52:11.275915 systemd[1]: Stopped target timers.target - Timer Units. May 22 18:52:11.282410 systemd[1]: iscsid.socket: Deactivated successfully. May 22 18:52:11.282795 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 22 18:52:11.286384 systemd[1]: iscsiuio.socket: Deactivated successfully. May 22 18:52:11.286466 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 22 18:52:11.289605 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. May 22 18:52:11.289718 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. May 22 18:52:11.296000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.293839 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 22 18:52:11.293929 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 22 18:52:11.301001 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 22 18:52:11.308770 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 22 18:52:11.310886 kernel: audit: type=1131 audit(1779475931.296:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.313772 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 22 18:52:11.312000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.321776 kernel: audit: type=1131 audit(1779475931.312:50): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.313892 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 22 18:52:11.314173 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 22 18:52:11.314371 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 22 18:52:11.317992 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 22 18:52:11.326892 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 22 18:52:11.330902 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 22 18:52:11.331200 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 22 18:52:11.341748 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 22 18:52:11.341864 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 22 18:52:11.343000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.344879 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 22 18:52:11.348000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.344977 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 22 18:52:11.352000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.358837 kernel: audit: type=1131 audit(1779475931.343:51): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.350173 systemd[1]: ignition-files.service: Deactivated successfully. May 22 18:52:11.353000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.373143 kernel: audit: type=1131 audit(1779475931.348:52): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.350272 systemd[1]: Stopped ignition-files.service - Ignition (files). May 22 18:52:11.374253 kernel: audit: type=1131 audit(1779475931.352:53): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.354470 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. May 22 18:52:11.377984 kernel: audit: type=1131 audit(1779475931.353:54): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.354560 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. May 22 18:52:11.355560 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 22 18:52:11.383000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.387000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.375851 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 22 18:52:11.393000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.378039 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 22 18:52:11.378172 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 22 18:52:11.403989 ignition[1994]: INFO : Ignition 2.24.0 May 22 18:52:11.403989 ignition[1994]: INFO : Stage: umount May 22 18:52:11.403989 ignition[1994]: INFO : no config dir at "/usr/lib/ignition/base.d" May 22 18:52:11.403989 ignition[1994]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:52:11.403989 ignition[1994]: INFO : umount: umount passed May 22 18:52:11.403989 ignition[1994]: INFO : Ignition finished successfully May 22 18:52:11.407000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.410000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.410000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.385541 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 22 18:52:11.385639 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 22 18:52:11.429000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.389435 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 22 18:52:11.432000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.389531 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 22 18:52:11.404588 systemd[1]: ignition-mount.service: Deactivated successfully. May 22 18:52:11.404703 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 22 18:52:11.449000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.409782 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 22 18:52:11.409892 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 22 18:52:11.414473 systemd[1]: Stopped target network.target - Network. May 22 18:52:11.422709 systemd[1]: ignition-disks.service: Deactivated successfully. May 22 18:52:11.424164 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 22 18:52:11.430254 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 22 18:52:11.430288 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 22 18:52:11.434676 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 22 18:52:11.472000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.474000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.475000 audit: BPF prog-id=8 op=UNLOAD May 22 18:52:11.475000 audit: BPF prog-id=5 op=UNLOAD May 22 18:52:11.440815 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 22 18:52:11.446495 systemd[1]: systemd-networkd.service: Deactivated successfully. May 22 18:52:11.446602 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 22 18:52:11.461844 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 22 18:52:11.464571 systemd[1]: systemd-resolved.service: Deactivated successfully. May 22 18:52:11.464689 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 22 18:52:11.475941 systemd[1]: sysroot-boot.service: Deactivated successfully. May 22 18:52:11.476032 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 22 18:52:11.497438 systemd[1]: Stopped target network-pre.target - Preparation for Network. May 22 18:52:11.499218 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 22 18:52:11.502000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.499252 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 22 18:52:11.501722 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 22 18:52:11.513000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.501756 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 22 18:52:11.517000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.505764 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 22 18:52:11.521000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.509759 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 22 18:52:11.509799 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 22 18:52:11.514759 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 22 18:52:11.514792 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 22 18:52:11.518733 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 22 18:52:11.518762 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 22 18:52:11.522762 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 22 18:52:11.587867 systemd[1]: systemd-udevd.service: Deactivated successfully. May 22 18:52:11.589000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.587971 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 22 18:52:11.592018 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 22 18:52:11.592091 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 22 18:52:11.599210 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 22 18:52:11.599240 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 22 18:52:11.603000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.605326 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 22 18:52:11.610000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.612000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.605355 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 22 18:52:11.618715 kernel: hv_netvsc f8615163-0000-1000-2000-6045bdc18de3 eth0: Data path switched from VF: enP30832s1 May 22 18:52:11.612765 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 22 18:52:11.624480 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 May 22 18:52:11.612804 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 22 18:52:11.622000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.624000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.618782 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 22 18:52:11.630000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.621756 systemd[1]: systemd-network-generator.service: Deactivated successfully. May 22 18:52:11.634000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.621791 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. May 22 18:52:11.638000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.624542 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 22 18:52:11.624578 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 22 18:52:11.642000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.626376 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. May 22 18:52:11.646000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.626409 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 22 18:52:11.646000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:11.632170 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 22 18:52:11.632204 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 22 18:52:11.635809 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 22 18:52:11.635845 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:52:11.640219 systemd[1]: network-cleanup.service: Deactivated successfully. May 22 18:52:11.640316 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 22 18:52:11.645189 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 22 18:52:11.645278 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 22 18:52:11.649697 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 22 18:52:11.656827 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 22 18:52:11.679171 systemd[1]: Switching root. May 22 18:52:11.725857 systemd-journald[1080]: Journal stopped May 22 18:52:17.194181 systemd-journald[1080]: Received SIGTERM from PID 1 (systemd). May 22 18:52:17.194253 kernel: SELinux: policy capability network_peer_controls=1 May 22 18:52:17.194279 kernel: SELinux: policy capability open_perms=1 May 22 18:52:17.194297 kernel: SELinux: policy capability extended_socket_class=1 May 22 18:52:17.194316 kernel: SELinux: policy capability always_check_network=0 May 22 18:52:17.194330 kernel: SELinux: policy capability cgroup_seclabel=1 May 22 18:52:17.194347 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 22 18:52:17.194361 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 22 18:52:17.194375 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 22 18:52:17.194389 kernel: SELinux: policy capability userspace_initial_context=0 May 22 18:52:17.194403 systemd[1]: Successfully loaded SELinux policy in 133.379ms. May 22 18:52:17.194424 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.460ms. May 22 18:52:17.194437 systemd[1]: systemd 258.3 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 22 18:52:17.194452 systemd[1]: Detected virtualization microsoft. May 22 18:52:17.194471 systemd[1]: Detected architecture x86-64. May 22 18:52:17.194487 systemd[1]: Detected first boot. May 22 18:52:17.194501 systemd[1]: Initializing machine ID from random generator. May 22 18:52:17.194516 systemd[1]: Hostname set to . May 22 18:52:17.194528 zram_generator::config[2040]: No configuration found. May 22 18:52:17.194551 kernel: Guest personality initialized and is inactive May 22 18:52:17.194564 kernel: VMCI host device registered (name=vmci, major=10, minor=259) May 22 18:52:17.194582 kernel: Initialized host personality May 22 18:52:17.194594 kernel: NET: Registered PF_VSOCK protocol family May 22 18:52:17.194611 systemd-ssh-generator[2036]: Failed to query local AF_VSOCK CID: Cannot assign requested address May 22 18:52:17.194629 (sd-exec-[2021]: /usr/lib/systemd/system-generators/systemd-ssh-generator failed with exit status 1. May 22 18:52:17.194646 systemd[1]: Applying preset policy. May 22 18:52:17.194681 systemd[1]: Created symlink '/etc/systemd/system/timers.target.wants/google-oslogin-cache.timer' → '/usr/lib/systemd/system/google-oslogin-cache.timer'. May 22 18:52:17.194698 systemd[1]: Created symlink '/etc/systemd/system/multi-user.target.wants/nfs-server.service' → '/usr/lib/systemd/system/nfs-server.service'. May 22 18:52:17.194708 systemd[1]: Populated /etc with preset unit settings. May 22 18:52:17.194724 kernel: kauditd_printk_skb: 33 callbacks suppressed May 22 18:52:17.194738 kernel: audit: type=1334 audit(1779475936.683:88): prog-id=10 op=LOAD May 22 18:52:17.194753 kernel: audit: type=1334 audit(1779475936.683:89): prog-id=2 op=UNLOAD May 22 18:52:17.194768 kernel: audit: type=1334 audit(1779475936.683:90): prog-id=11 op=LOAD May 22 18:52:17.194779 kernel: audit: type=1334 audit(1779475936.683:91): prog-id=12 op=LOAD May 22 18:52:17.194792 kernel: audit: type=1334 audit(1779475936.683:92): prog-id=3 op=UNLOAD May 22 18:52:17.194805 kernel: audit: type=1334 audit(1779475936.683:93): prog-id=4 op=UNLOAD May 22 18:52:17.194815 kernel: audit: type=1334 audit(1779475936.684:94): prog-id=13 op=LOAD May 22 18:52:17.194831 kernel: audit: type=1334 audit(1779475936.684:95): prog-id=10 op=UNLOAD May 22 18:52:17.194846 kernel: audit: type=1334 audit(1779475936.684:96): prog-id=14 op=LOAD May 22 18:52:17.194855 kernel: audit: type=1334 audit(1779475936.684:97): prog-id=15 op=LOAD May 22 18:52:17.194872 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 22 18:52:17.194885 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 22 18:52:17.194899 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 22 18:52:17.194913 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 22 18:52:17.194927 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 22 18:52:17.194943 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 22 18:52:17.194956 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 22 18:52:17.194971 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 22 18:52:17.194984 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 22 18:52:17.194997 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 22 18:52:17.195010 systemd[1]: Created slice user.slice - User and Session Slice. May 22 18:52:17.195026 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 22 18:52:17.195037 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 22 18:52:17.195049 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 22 18:52:17.195060 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 22 18:52:17.195076 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 22 18:52:17.195091 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 22 18:52:17.195107 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... May 22 18:52:17.195118 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... May 22 18:52:17.195132 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 22 18:52:17.195144 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 22 18:52:17.195157 systemd[1]: Reached target imports.target - Image Downloads. May 22 18:52:17.195168 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 22 18:52:17.195186 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 22 18:52:17.195200 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 22 18:52:17.195211 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 22 18:52:17.195222 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 22 18:52:17.195237 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 22 18:52:17.195250 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. May 22 18:52:17.195265 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. May 22 18:52:17.195276 systemd[1]: Reached target slices.target - Slice Units. May 22 18:52:17.195288 systemd[1]: Reached target swap.target - Swaps. May 22 18:52:17.195301 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 22 18:52:17.195312 systemd[1]: Listening on rpcbind.socket - RPCbind Server Activation Socket. May 22 18:52:17.195326 systemd[1]: Reached target rpcbind.target - RPC Port Mapper. May 22 18:52:17.195337 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. May 22 18:52:17.195348 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 22 18:52:17.195358 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 22 18:52:17.195371 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. May 22 18:52:17.195381 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. May 22 18:52:17.195393 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. May 22 18:52:17.195405 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Service Varlink Socket. May 22 18:52:17.195415 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 22 18:52:17.195428 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. May 22 18:52:17.195440 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. May 22 18:52:17.195450 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. May 22 18:52:17.195461 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. May 22 18:52:17.195475 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 22 18:52:17.195486 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. May 22 18:52:17.195499 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 22 18:52:17.195509 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 22 18:52:17.195519 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 22 18:52:17.195530 systemd[1]: Mounting media.mount - External Media Directory... May 22 18:52:17.195543 systemd[1]: Mounting proc-fs-nfsd.mount - NFSD configuration filesystem... May 22 18:52:17.195554 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 22 18:52:17.195570 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 22 18:52:17.195583 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 22 18:52:17.195593 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. May 22 18:52:17.195608 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 22 18:52:17.195620 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). May 22 18:52:17.195635 systemd[1]: Reached target machines.target - Virtual Machines and Containers. May 22 18:52:17.195644 systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). May 22 18:52:17.195653 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 22 18:52:17.195684 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 22 18:52:17.195697 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 22 18:52:17.195710 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 22 18:52:17.195721 systemd[1]: modprobe@dm_mod.service - Load Kernel Module dm_mod was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!dm_mod). May 22 18:52:17.195730 systemd[1]: modprobe@drm.service - Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). May 22 18:52:17.195740 systemd[1]: modprobe@efi_pstore.service - Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). May 22 18:52:17.195749 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 22 18:52:17.195758 systemd[1]: modprobe@loop.service - Load Kernel Module loop was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!loop). May 22 18:52:17.195771 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 22 18:52:17.195782 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 22 18:52:17.195793 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 22 18:52:17.195809 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 22 18:52:17.195819 systemd[1]: Stopped systemd-fsck-usr.service. May 22 18:52:17.195833 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 22 18:52:17.195844 systemd[1]: Starting systemd-journald.service - Journal Service... May 22 18:52:17.195860 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 22 18:52:17.195870 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... May 22 18:52:17.195880 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 22 18:52:17.195893 systemd[1]: Reached target time-set.target - System Time Set. May 22 18:52:17.195905 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 22 18:52:17.195915 kernel: RPC: Registered named UNIX socket transport module. May 22 18:52:17.195928 kernel: RPC: Registered udp transport module. May 22 18:52:17.195938 kernel: RPC: Registered tcp transport module. May 22 18:52:17.195948 kernel: RPC: Registered tcp-with-tls transport module. May 22 18:52:17.195960 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 22 18:52:17.195972 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. May 22 18:52:17.195982 kernel: fuse: init (API version 7.41) May 22 18:52:17.195992 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 22 18:52:17.196003 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 22 18:52:17.196041 systemd-journald[2123]: Collecting audit messages is enabled. May 22 18:52:17.196068 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 22 18:52:17.196081 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 22 18:52:17.196093 systemd-journald[2123]: Journal started May 22 18:52:17.196118 systemd-journald[2123]: Runtime Journal (/run/log/journal/44ac92b85f984959916d66dd2ed5432b) is 8M, max 158.5M, 150.5M free. May 22 18:52:16.841000 audit[1]: EVENT_LISTENER pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 May 22 18:52:17.059000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.064000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.069000 audit: BPF prog-id=18 op=UNLOAD May 22 18:52:17.069000 audit: BPF prog-id=17 op=UNLOAD May 22 18:52:17.069000 audit: BPF prog-id=19 op=LOAD May 22 18:52:17.069000 audit: BPF prog-id=20 op=LOAD May 22 18:52:17.069000 audit: BPF prog-id=21 op=LOAD May 22 18:52:17.181000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 May 22 18:52:17.181000 audit[2123]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=6 a1=7ffd3d9987a0 a2=4000 a3=0 items=0 ppid=1 pid=2123 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) May 22 18:52:17.181000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" May 22 18:52:16.677134 systemd[1]: Queued start job for default target multi-user.target. May 22 18:52:16.687902 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. May 22 18:52:16.688410 systemd[1]: systemd-journald.service: Deactivated successfully. May 22 18:52:17.201835 systemd[1]: Started systemd-journald.service - Journal Service. May 22 18:52:17.202000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.204246 systemd[1]: Mounted media.mount - External Media Directory. May 22 18:52:17.205619 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 22 18:52:17.208802 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 22 18:52:17.211794 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 22 18:52:17.214907 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 22 18:52:17.214000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.216313 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 22 18:52:17.216434 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 22 18:52:17.219915 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 22 18:52:17.220050 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 22 18:52:17.218000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.218000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.221000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.221000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.222977 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 22 18:52:17.224000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.226116 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. May 22 18:52:17.226000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.230123 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 22 18:52:17.230000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.239332 systemd[1]: Reached target network-pre.target - Preparation for Network. May 22 18:52:17.244159 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. May 22 18:52:17.246360 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 22 18:52:17.250832 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 22 18:52:17.254777 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 22 18:52:17.254811 systemd[1]: Reached target local-fs.target - Local File Systems. May 22 18:52:17.260619 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 22 18:52:17.263766 systemd[1]: rpc-svcgssd.service - RPC security service for NFS server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). May 22 18:52:17.263893 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 22 18:52:17.270508 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... May 22 18:52:17.291026 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 22 18:52:17.294859 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 22 18:52:17.296910 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 22 18:52:17.298804 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 22 18:52:17.304877 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 22 18:52:17.314062 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 22 18:52:17.318028 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... May 22 18:52:17.331823 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 22 18:52:17.336198 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 22 18:52:17.333000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.339640 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 22 18:52:17.347073 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 22 18:52:17.350000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.355193 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 22 18:52:17.365976 systemd-journald[2123]: Time spent on flushing to /var/log/journal/44ac92b85f984959916d66dd2ed5432b is 42.561ms for 1207 entries. May 22 18:52:17.365976 systemd-journald[2123]: System Journal (/var/log/journal/44ac92b85f984959916d66dd2ed5432b) is 8M, max 2.2G, 2.2G free. May 22 18:52:17.383000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.392000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdb-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.436000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.364780 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 22 18:52:17.442980 systemd-journald[2123]: Received client request to flush runtime journal. May 22 18:52:17.383481 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 22 18:52:17.443753 kernel: loop4: detected capacity change from 0 to 43464 May 22 18:52:17.390937 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. May 22 18:52:17.443847 kernel: loop4: p1 p2 p3 May 22 18:52:17.435715 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 22 18:52:17.444017 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 22 18:52:17.446000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.449286 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 22 18:52:17.451000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.540060 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:17.540136 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:17.542628 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:17.544492 systemd-confext[2186]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:52:17.544794 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:17.549681 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:17.595507 systemd-tmpfiles[2182]: ACLs are not supported, ignoring. May 22 18:52:17.595525 systemd-tmpfiles[2182]: ACLs are not supported, ignoring. May 22 18:52:17.609452 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 22 18:52:17.613000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.615797 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 22 18:52:17.619000 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-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.627874 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 22 18:52:17.651854 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 22 18:52:17.651955 systemd[1]: Mounted proc-fs-nfsd.mount - NFSD configuration filesystem. May 22 18:52:17.892063 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 22 18:52:17.892000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.893000 audit: BPF prog-id=22 op=LOAD May 22 18:52:17.893000 audit: BPF prog-id=23 op=LOAD May 22 18:52:17.893000 audit: BPF prog-id=24 op=LOAD May 22 18:52:17.896108 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... May 22 18:52:17.897000 audit: BPF prog-id=25 op=LOAD May 22 18:52:17.901266 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 22 18:52:17.905863 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 22 18:52:17.917862 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... May 22 18:52:17.922000 audit: BPF prog-id=26 op=LOAD May 22 18:52:17.922000 audit: BPF prog-id=27 op=LOAD May 22 18:52:17.922000 audit: BPF prog-id=28 op=LOAD May 22 18:52:17.924970 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 22 18:52:17.942324 systemd-tmpfiles[2213]: ACLs are not supported, ignoring. May 22 18:52:17.942344 systemd-tmpfiles[2213]: ACLs are not supported, ignoring. May 22 18:52:17.946236 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 22 18:52:17.947000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:17.978151 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 22 18:52:17.978000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.035609 systemd[1]: modprobe@tun.service: Deactivated successfully. May 22 18:52:18.035719 kernel: tun: Universal TUN/TAP device driver, 1.6 May 22 18:52:18.035831 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. May 22 18:52:18.036000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.036000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.037000 audit: BPF prog-id=29 op=LOAD May 22 18:52:18.037000 audit: BPF prog-id=30 op=LOAD May 22 18:52:18.037000 audit: BPF prog-id=31 op=LOAD May 22 18:52:18.039350 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... May 22 18:52:18.094191 systemd-nsresourced[2224]: Not setting up BPF subsystem, as functionality has been disabled at compile time. May 22 18:52:18.095449 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. May 22 18:52:18.095000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-nsresourced comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.144897 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 22 18:52:18.145000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.146000 audit: BPF prog-id=7 op=UNLOAD May 22 18:52:18.146000 audit: BPF prog-id=6 op=UNLOAD May 22 18:52:18.146000 audit: BPF prog-id=32 op=LOAD May 22 18:52:18.146000 audit: BPF prog-id=33 op=LOAD May 22 18:52:18.149033 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 22 18:52:18.196289 systemd-udevd[2235]: Using default interface naming scheme 'v258'. May 22 18:52:18.213956 systemd-oomd[2211]: No swap; memory pressure usage will be degraded May 22 18:52:18.214615 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. May 22 18:52:18.216000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-oomd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.242990 systemd-resolved[2212]: Positive Trust Anchors: May 22 18:52:18.243003 systemd-resolved[2212]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 22 18:52:18.243006 systemd-resolved[2212]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 May 22 18:52:18.243043 systemd-resolved[2212]: 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 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test May 22 18:52:18.343957 systemd-resolved[2212]: Using system hostname 'ci-4694.0.1-a-51b1c0bae6'. May 22 18:52:18.345003 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 22 18:52:18.345000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.346887 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 22 18:52:18.370542 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 22 18:52:18.372000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.373000 audit: BPF prog-id=34 op=LOAD May 22 18:52:18.376805 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 22 18:52:18.462482 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. May 22 18:52:18.496733 systemd-networkd[2237]: lo: Link UP May 22 18:52:18.496743 systemd-networkd[2237]: lo: Gained carrier May 22 18:52:18.499333 systemd[1]: Started systemd-networkd.service - Network Configuration. May 22 18:52:18.499000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.501614 systemd[1]: Reached target network.target - Network. May 22 18:52:18.506289 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 22 18:52:18.509366 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 22 18:52:18.547293 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 22 18:52:18.548000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-persistent-storage comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.588069 systemd-networkd[2237]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network May 22 18:52:18.588082 systemd-networkd[2237]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 22 18:52:18.592695 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 May 22 18:52:18.597178 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 May 22 18:52:18.597464 kernel: hv_netvsc f8615163-0000-1000-2000-6045bdc18de3 eth0: Data path switched to VF: enP30832s1 May 22 18:52:18.600686 systemd-networkd[2237]: enP30832s1: Link UP May 22 18:52:18.600772 systemd-networkd[2237]: eth0: Link UP May 22 18:52:18.600778 systemd-networkd[2237]: eth0: Gained carrier May 22 18:52:18.600796 systemd-networkd[2237]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network May 22 18:52:18.606716 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#299 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 May 22 18:52:18.606855 systemd-networkd[2237]: enP30832s1: Gained carrier May 22 18:52:18.610688 kernel: mousedev: PS/2 mouse device common for all mice May 22 18:52:18.615747 systemd-networkd[2237]: eth0: DHCPv4 address 10.0.0.23/24, gateway 10.0.0.1 acquired from 168.63.129.16 May 22 18:52:18.631676 kernel: hv_vmbus: registering driver hyperv_fb May 22 18:52:18.643030 kernel: hyperv_fb: Synthvid Version major 3, minor 5 May 22 18:52:18.643086 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 May 22 18:52:18.644847 kernel: Console: switching to colour dummy device 80x25 May 22 18:52:18.649232 kernel: Console: switching to colour frame buffer device 128x48 May 22 18:52:18.677687 kernel: hv_vmbus: registering driver hv_balloon May 22 18:52:18.691507 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. May 22 18:52:18.707692 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 May 22 18:52:18.776951 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:52:18.782787 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 22 18:52:18.783037 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:52:18.784000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.784000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.787730 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:52:18.834989 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 22 18:52:18.836729 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:52:18.837000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.837000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.842010 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:52:18.854676 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. May 22 18:52:18.877687 kernel: loop4: detected capacity change from 0 to 43464 May 22 18:52:18.880683 kernel: loop4: p1 p2 p3 May 22 18:52:18.892729 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:18.892783 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:18.894506 (sd-merge)[2318]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:52:18.894811 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:18.894832 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:18.898686 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:18.932696 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. May 22 18:52:18.934489 (sd-merge)[2318]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. May 22 18:52:18.943719 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. May 22 18:52:18.945000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-confext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:18.949810 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 22 18:52:18.967676 kernel: loop4: detected capacity change from 0 to 378016 May 22 18:52:18.968731 kernel: loop4: p1 p2 p3 May 22 18:52:18.996747 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:18.996797 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:18.999672 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:19.000396 systemd-sysext[2327]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:52:19.000674 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:19.005679 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.056879 kernel: kvm_intel: Using Hyper-V Enlightened VMCS May 22 18:52:19.063744 kernel: cpu_based_exec_ctrl unsupported with eVMCS: 0x20000 May 22 18:52:19.083689 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. May 22 18:52:19.110102 kernel: loop4: detected capacity change from 0 to 178200 May 22 18:52:19.113681 kernel: loop4: p1 p2 p3 May 22 18:52:19.118677 kernel: loop4: p1 p2 p3 May 22 18:52:19.122096 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. May 22 18:52:19.124897 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 22 18:52:19.142527 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.142580 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:19.147040 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:19.147091 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:19.147703 systemd-sysext[2327]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:52:19.150677 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.181631 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 22 18:52:19.180000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-OEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:19.190688 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. May 22 18:52:19.215970 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:52:19.216000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:19.219708 kernel: loop4: detected capacity change from 0 to 136912 May 22 18:52:19.221682 kernel: loop4: p1 p2 p3 May 22 18:52:19.237640 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.237704 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:19.241686 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:19.242712 systemd-sysext[2327]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:52:19.243696 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:19.245677 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.269673 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. May 22 18:52:19.296688 kernel: loop4: detected capacity change from 0 to 378016 May 22 18:52:19.296796 kernel: loop4: p1 p2 p3 May 22 18:52:19.302690 kernel: loop4: p1 p2 p3 May 22 18:52:19.318041 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.318087 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:19.318779 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:19.319742 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:19.319772 (sd-merge)[2369]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:52:19.321676 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.354703 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. May 22 18:52:19.358682 kernel: loop5: detected capacity change from 0 to 178200 May 22 18:52:19.368680 kernel: loop5: p1 p2 p3 May 22 18:52:19.370679 kernel: loop5: p1 p2 p3 May 22 18:52:19.381018 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.381068 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:19.381976 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:19.382896 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:19.383259 (sd-merge)[2369]: device-mapper: reload ioctl on loop5p1-verity (254:6) failed: Invalid argument May 22 18:52:19.385681 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.408680 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. May 22 18:52:19.410685 kernel: loop6: detected capacity change from 0 to 136912 May 22 18:52:19.413691 kernel: loop6: p1 p2 p3 May 22 18:52:19.424569 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.424618 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:52:19.426083 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) May 22 18:52:19.426134 kernel: device-mapper: ioctl: error adding target to table May 22 18:52:19.426306 (sd-merge)[2369]: device-mapper: reload ioctl on loop6p1-verity (254:7) failed: Invalid argument May 22 18:52:19.428678 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:52:19.445683 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. May 22 18:52:19.445956 (sd-merge)[2369]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. May 22 18:52:19.448081 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 22 18:52:19.449000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:19.451746 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 22 18:52:19.474127 systemd-tmpfiles[2392]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. May 22 18:52:19.474652 systemd-tmpfiles[2392]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. May 22 18:52:19.474938 systemd-tmpfiles[2392]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 22 18:52:19.475635 systemd-tmpfiles[2392]: ACLs are not supported, ignoring. May 22 18:52:19.475736 systemd-tmpfiles[2392]: ACLs are not supported, ignoring. May 22 18:52:19.493988 systemd-tmpfiles[2392]: Detected autofs mount point /boot during canonicalization of boot. May 22 18:52:19.493997 systemd-tmpfiles[2392]: Skipping /boot May 22 18:52:19.498339 systemd-tmpfiles[2392]: Detected autofs mount point /boot during canonicalization of boot. May 22 18:52:19.498352 systemd-tmpfiles[2392]: Skipping /boot May 22 18:52:19.506241 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 22 18:52:19.509000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:19.511801 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 22 18:52:19.516796 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 22 18:52:19.520526 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 22 18:52:19.521000 audit: BPF prog-id=35 op=LOAD May 22 18:52:19.525826 systemd[1]: Starting rpcbind.service - RPC Bind... May 22 18:52:19.529679 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 22 18:52:19.540420 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 22 18:52:19.543889 systemd[1]: boot.automount: Got automount request for /boot, triggered by 2401 ((rpcbind)) May 22 18:52:19.545636 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service - File System Check on /dev/disk/by-label/EFI-SYSTEM... May 22 18:52:19.572000 audit[2409]: AUDIT1127 pid=2409 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' May 22 18:52:19.577047 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 22 18:52:19.578000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:19.657211 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 22 18:52:19.655000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:19.700029 systemd[1]: Mounting var-lib-nfs-rpc_pipefs.mount - RPC Pipe File System... May 22 18:52:19.713816 systemd[1]: Mounted var-lib-nfs-rpc_pipefs.mount - RPC Pipe File System. May 22 18:52:19.714423 systemd[1]: Reached target rpc_pipefs.target. May 22 18:52:19.717773 systemd[1]: Starting nfsdcld.service - NFSv4 Client Tracking Daemon... May 22 18:52:19.717847 systemd[1]: rpc-gssd.service - RPC security service for NFS client and server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). May 22 18:52:19.871695 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 22 18:52:19.870000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=clean-ca-certificates comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:19.871983 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). May 22 18:52:19.915000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 May 22 18:52:19.915000 audit[2433]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffd83f231d0 a2=420 a3=0 items=0 ppid=2398 pid=2433 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) May 22 18:52:19.915000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 May 22 18:52:19.917395 augenrules[2433]: No rules May 22 18:52:19.917679 systemd[1]: audit-rules.service: Deactivated successfully. May 22 18:52:19.917897 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 22 18:52:20.019312 systemd[1]: Started nfsdcld.service - NFSv4 Client Tracking Daemon. May 22 18:52:20.124986 systemd-fsck[2413]: fsck.fat 4.2 (2021-01-31) May 22 18:52:20.124986 systemd-fsck[2413]: /dev/nvme0n1p1: 468 files, 10316/261627 clusters May 22 18:52:20.127230 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service - File System Check on /dev/disk/by-label/EFI-SYSTEM. May 22 18:52:20.131942 systemd[1]: Mounting boot.mount - Boot partition... May 22 18:52:20.152468 systemd[1]: Mounted boot.mount - Boot partition. May 22 18:52:20.175208 (rpcbind)[2401]: rpcbind.service: Referenced but unset environment variable evaluates to an empty string: RPCBIND_OPTIONS May 22 18:52:20.220788 systemd-networkd[2237]: eth0: Gained IPv6LL May 22 18:52:20.222618 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 22 18:52:20.224511 systemd[1]: Reached target network-online.target - Network is Online. May 22 18:52:20.233530 systemd[1]: Starting nfs-idmapd.service - NFSv4 ID-name mapping service... May 22 18:52:20.239771 systemd[1]: Starting nfs-mountd.service - NFS Mount Daemon... May 22 18:52:20.272527 rpc.idmapd[2448]: Setting log level to 0 May 22 18:52:20.414066 systemd[1]: Started nfs-idmapd.service - NFSv4 ID-name mapping service. May 22 18:52:20.461268 systemd[1]: Started rpcbind.service - RPC Bind. May 22 18:52:20.465763 systemd[1]: Starting rpc-statd.service - NFS status monitor for NFSv2/3 locking.... May 22 18:52:20.471993 rpc.mountd[2451]: Version 2.7.1 starting May 22 18:52:20.472945 systemd[1]: Started nfs-mountd.service - NFS Mount Daemon. May 22 18:52:20.546014 rpc.statd[2453]: Version 2.7.1 starting May 22 18:52:20.546021 rpc.statd[2453]: Flags: TI-RPC May 22 18:52:20.546780 rpc.statd[2453]: Failed to read /var/lib/nfs/state: Success May 22 18:52:20.546787 rpc.statd[2453]: Initializing NSM state May 22 18:52:20.553373 systemd[1]: Started rpc-statd.service - NFS status monitor for NFSv2/3 locking.. May 22 18:52:20.556147 systemd[1]: Starting nfs-server.service - NFS server and services... May 22 18:52:20.735895 kernel: NFSD: Using nfsdcld client tracking operations. May 22 18:52:20.735987 kernel: NFSD: no clients to reclaim, skipping NFSv4 grace period (net f0000000) May 22 18:52:20.752579 systemd[1]: Finished nfs-server.service - NFS server and services. May 22 18:52:20.756838 systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... May 22 18:52:20.786905 sm-notify[2468]: Version 2.7.1 starting May 22 18:52:20.787523 systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. May 22 18:52:26.836299 ldconfig[2400]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 22 18:52:26.846961 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 22 18:52:26.849882 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 22 18:52:26.867969 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 22 18:52:26.870993 systemd[1]: Reached target sysinit.target - System Initialization. May 22 18:52:26.873839 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 22 18:52:26.876798 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. May 22 18:52:26.879761 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. May 22 18:52:26.882788 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 22 18:52:26.885843 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 22 18:52:26.887406 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. May 22 18:52:26.889427 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. May 22 18:52:26.892713 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 22 18:52:26.894352 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 22 18:52:26.894390 systemd[1]: Reached target paths.target - Path Units. May 22 18:52:26.895454 systemd[1]: Reached target timers.target - Timer Units. May 22 18:52:26.898234 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 22 18:52:26.916916 systemd[1]: Starting docker.socket - Docker Socket for the API... May 22 18:52:26.919379 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 22 18:52:26.922933 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 22 18:52:26.924440 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 22 18:52:26.929207 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. May 22 18:52:26.930812 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. May 22 18:52:26.932931 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 22 18:52:26.936458 systemd[1]: Reached target sockets.target - Socket Units. May 22 18:52:26.938710 systemd[1]: Reached target basic.target - Basic System. May 22 18:52:26.941771 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 22 18:52:26.941798 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 22 18:52:26.943425 systemd[1]: Starting chronyd.service - NTP client/server... May 22 18:52:26.950755 systemd[1]: Starting containerd.service - containerd container runtime... May 22 18:52:26.962722 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... May 22 18:52:26.968233 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 22 18:52:26.975689 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 22 18:52:26.978930 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 22 18:52:26.982596 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 22 18:52:26.984080 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). May 22 18:52:26.987529 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... May 22 18:52:26.990799 systemd[1]: hv_fcopy_uio_daemon.service - Hyper-V FCOPY UIO daemon was skipped because of an unmet condition check (ConditionPathExists=/sys/bus/vmbus/devices/eb765408-105f-49b6-b4aa-c123b64d17d4/uio). May 22 18:52:26.993904 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. May 22 18:52:26.997803 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). May 22 18:52:27.000993 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 22 18:52:27.005850 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 22 18:52:27.009168 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 22 18:52:27.012828 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 22 18:52:27.019047 KVP[2486]: KVP starting; pid is:2486 May 22 18:52:27.021157 systemd[1]: Starting systemd-logind.service - User Login Management... May 22 18:52:27.023046 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 22 18:52:27.025860 systemd[1]: Starting update-engine.service - Update Engine... May 22 18:52:27.028679 kernel: hv_utils: KVP IC version 4.0 May 22 18:52:27.031708 KVP[2486]: KVP LIC Version: 3.1 May 22 18:52:27.034300 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 22 18:52:27.038626 jq[2483]: false May 22 18:52:27.047406 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 22 18:52:27.050098 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 22 18:52:27.050309 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 22 18:52:27.059380 jq[2496]: true May 22 18:52:27.068557 chronyd[2475]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) May 22 18:52:27.073891 systemd[1]: motdgen.service: Deactivated successfully. May 22 18:52:27.074121 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 22 18:52:27.076478 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 22 18:52:27.077887 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 22 18:52:27.083521 google_oslogin_nss_cache[2485]: oslogin_cache_refresh[2485]: Refreshing passwd entry cache May 22 18:52:27.082373 oslogin_cache_refresh[2485]: Refreshing passwd entry cache May 22 18:52:27.087104 extend-filesystems[2484]: Found /dev/nvme0n1p6 May 22 18:52:27.096417 jq[2505]: true May 22 18:52:27.101319 chronyd[2475]: Timezone right/UTC failed leap second check, ignoring May 22 18:52:27.101465 chronyd[2475]: Loaded seccomp filter (level 2) May 22 18:52:27.101598 systemd[1]: Started chronyd.service - NTP client/server. May 22 18:52:27.105148 google_oslogin_nss_cache[2485]: oslogin_cache_refresh[2485]: Failure getting users, quitting May 22 18:52:27.105148 google_oslogin_nss_cache[2485]: oslogin_cache_refresh[2485]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 22 18:52:27.105148 google_oslogin_nss_cache[2485]: oslogin_cache_refresh[2485]: Refreshing group entry cache May 22 18:52:27.105013 oslogin_cache_refresh[2485]: Failure getting users, quitting May 22 18:52:27.105030 oslogin_cache_refresh[2485]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 22 18:52:27.105073 oslogin_cache_refresh[2485]: Refreshing group entry cache May 22 18:52:27.110617 extend-filesystems[2484]: Found /dev/nvme0n1p9 May 22 18:52:27.116280 extend-filesystems[2484]: Checking size of /dev/nvme0n1p9 May 22 18:52:27.120956 google_oslogin_nss_cache[2485]: oslogin_cache_refresh[2485]: Failure getting groups, quitting May 22 18:52:27.120956 google_oslogin_nss_cache[2485]: oslogin_cache_refresh[2485]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 22 18:52:27.120725 oslogin_cache_refresh[2485]: Failure getting groups, quitting May 22 18:52:27.120734 oslogin_cache_refresh[2485]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 22 18:52:27.122949 systemd[1]: google-oslogin-cache.service: Deactivated successfully. May 22 18:52:27.123201 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. May 22 18:52:27.135280 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 22 18:52:27.140685 extend-filesystems[2484]: Resized partition /dev/nvme0n1p9 May 22 18:52:27.162591 extend-filesystems[2554]: resize2fs 1.47.3 (8-Jul-2025) May 22 18:52:27.167571 systemd-logind[2491]: New seat seat0. May 22 18:52:27.168575 systemd-logind[2491]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) May 22 18:52:27.168842 systemd[1]: Started systemd-logind.service - User Login Management. May 22 18:52:27.201705 update_engine[2493]: I20260522 18:52:27.201321 2493 main.cc:92] Flatcar Update Engine starting May 22 18:52:27.204044 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 6359552 to 6376955 blocks May 22 18:52:27.204134 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 6376955 May 22 18:52:27.246924 extend-filesystems[2554]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required May 22 18:52:27.246924 extend-filesystems[2554]: old_desc_blocks = 4, new_desc_blocks = 4 May 22 18:52:27.246924 extend-filesystems[2554]: The filesystem on /dev/nvme0n1p9 is now 6376955 (4k) blocks long. May 22 18:52:27.256960 extend-filesystems[2484]: Resized filesystem in /dev/nvme0n1p9 May 22 18:52:27.247637 systemd[1]: extend-filesystems.service: Deactivated successfully. May 22 18:52:27.249912 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 22 18:52:27.288126 bash[2545]: Updated "/home/core/.ssh/authorized_keys" May 22 18:52:27.294722 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 22 18:52:27.306100 dbus-daemon[2478]: [system] SELinux support is enabled May 22 18:52:27.307290 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 22 18:52:27.316672 update_engine[2493]: I20260522 18:52:27.315143 2493 update_check_scheduler.cc:74] Next update check in 3m53s May 22 18:52:27.317729 dbus-daemon[2478]: [system] Successfully activated service 'org.freedesktop.systemd1' May 22 18:52:27.318670 systemd[1]: Started update-engine.service - Update Engine. May 22 18:52:27.322974 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 22 18:52:27.356794 sshd_keygen[2529]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 22 18:52:27.389276 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). May 22 18:52:27.389456 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 22 18:52:27.392813 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). May 22 18:52:27.392953 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 22 18:52:27.396878 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 22 18:52:27.401537 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 22 18:52:27.413358 coreos-metadata[2477]: May 22 18:52:27.413 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 May 22 18:52:27.416940 systemd[1]: Starting issuegen.service - Generate /run/issue... May 22 18:52:27.419088 coreos-metadata[2477]: May 22 18:52:27.418 INFO Fetch successful May 22 18:52:27.419088 coreos-metadata[2477]: May 22 18:52:27.419 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 May 22 18:52:27.419823 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... May 22 18:52:27.423017 coreos-metadata[2477]: May 22 18:52:27.422 INFO Fetch successful May 22 18:52:27.423117 coreos-metadata[2477]: May 22 18:52:27.423 INFO Fetching http://168.63.129.16/machine/48ad4288-c2be-43ae-8c47-7e0b18385e56/a1dc5881%2D7023%2D4ecd%2Da0e6%2Db7190cc87b64.%5Fci%2D4694.0.1%2Da%2D51b1c0bae6?comp=config&type=sharedConfig&incarnation=1: Attempt #1 May 22 18:52:27.424453 coreos-metadata[2477]: May 22 18:52:27.424 INFO Fetch successful May 22 18:52:27.424554 coreos-metadata[2477]: May 22 18:52:27.424 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 May 22 18:52:27.433501 systemd[1]: issuegen.service: Deactivated successfully. May 22 18:52:27.433769 systemd[1]: Finished issuegen.service - Generate /run/issue. May 22 18:52:27.446857 coreos-metadata[2477]: May 22 18:52:27.444 INFO Fetch successful May 22 18:52:27.450533 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 22 18:52:27.466953 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. May 22 18:52:27.478817 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 22 18:52:27.482007 systemd[1]: Started getty@tty1.service - Getty on tty1. May 22 18:52:27.485929 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. May 22 18:52:27.487596 systemd[1]: Reached target getty.target - Login Prompts. May 22 18:52:27.491756 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. May 22 18:52:27.495391 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 22 18:52:27.952896 locksmithd[2594]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 22 18:52:29.262118 containerd[2512]: time="2026-05-22T18:52:29Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 May 22 18:52:29.263541 containerd[2512]: time="2026-05-22T18:52:29.263495169Z" level=info msg="starting containerd" revision=dea7da592f5d1d2b7755e3a161be07f43fad8f75 version=v2.2.1 May 22 18:52:29.274739 containerd[2512]: time="2026-05-22T18:52:29.274687711Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="29.217µs" May 22 18:52:29.274739 containerd[2512]: time="2026-05-22T18:52:29.274732305Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 22 18:52:29.274845 containerd[2512]: time="2026-05-22T18:52:29.274770532Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 22 18:52:29.274845 containerd[2512]: time="2026-05-22T18:52:29.274781333Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 22 18:52:29.274954 containerd[2512]: time="2026-05-22T18:52:29.274936764Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 22 18:52:29.274987 containerd[2512]: time="2026-05-22T18:52:29.274954490Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 May 22 18:52:29.274987 containerd[2512]: time="2026-05-22T18:52:29.274967586Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 22 18:52:29.275036 containerd[2512]: time="2026-05-22T18:52:29.275017319Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 22 18:52:29.275058 containerd[2512]: time="2026-05-22T18:52:29.275033496Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 22 18:52:29.275241 containerd[2512]: time="2026-05-22T18:52:29.275222856Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 22 18:52:29.275241 containerd[2512]: time="2026-05-22T18:52:29.275237073Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 22 18:52:29.275291 containerd[2512]: time="2026-05-22T18:52:29.275247970Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 22 18:52:29.275291 containerd[2512]: time="2026-05-22T18:52:29.275262008Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 May 22 18:52:29.275424 containerd[2512]: time="2026-05-22T18:52:29.275408796Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 22 18:52:29.275481 containerd[2512]: time="2026-05-22T18:52:29.275467414Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 22 18:52:29.275618 containerd[2512]: time="2026-05-22T18:52:29.275599647Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 22 18:52:29.275646 containerd[2512]: time="2026-05-22T18:52:29.275627318Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 22 18:52:29.275646 containerd[2512]: time="2026-05-22T18:52:29.275638789Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 22 18:52:29.276105 containerd[2512]: time="2026-05-22T18:52:29.276077293Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 22 18:52:29.277367 containerd[2512]: time="2026-05-22T18:52:29.277341704Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 22 18:52:29.277438 containerd[2512]: time="2026-05-22T18:52:29.277422499Z" level=info msg="metadata content store policy set" policy=shared May 22 18:52:29.291130 containerd[2512]: time="2026-05-22T18:52:29.290569115Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 22 18:52:29.291130 containerd[2512]: time="2026-05-22T18:52:29.290615899Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 22 18:52:29.291130 containerd[2512]: time="2026-05-22T18:52:29.290642187Z" level=info msg="built-in NRI default validator is disabled" May 22 18:52:29.291130 containerd[2512]: time="2026-05-22T18:52:29.290649573Z" level=info msg="runtime interface created" May 22 18:52:29.291130 containerd[2512]: time="2026-05-22T18:52:29.290654605Z" level=info msg="created NRI interface" May 22 18:52:29.291130 containerd[2512]: time="2026-05-22T18:52:29.290673113Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349185464Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349227904Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349243777Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349387442Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349406094Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349417078Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349428906Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349443128Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349455302Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349466269Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349476988Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349496567Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349611109Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 22 18:52:29.350004 containerd[2512]: time="2026-05-22T18:52:29.349629431Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349641696Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349653140Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349683117Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349695453Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349708785Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349721101Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349731804Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349741753Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349754981Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349765411Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.349879854Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.350028302Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.350041276Z" level=info msg="Start snapshots syncer" May 22 18:52:29.350427 containerd[2512]: time="2026-05-22T18:52:29.350065582Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 22 18:52:29.351446 containerd[2512]: time="2026-05-22T18:52:29.350368520Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" May 22 18:52:29.351446 containerd[2512]: time="2026-05-22T18:52:29.350423570Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350465700Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350558621Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350583672Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350595501Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350608372Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350620493Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350632398Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350642902Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350655591Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350910327Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350961700Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350978928Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 22 18:52:29.351611 containerd[2512]: time="2026-05-22T18:52:29.350987996Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 22 18:52:29.351944 containerd[2512]: time="2026-05-22T18:52:29.351000779Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 22 18:52:29.351944 containerd[2512]: time="2026-05-22T18:52:29.351008983Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 22 18:52:29.351944 containerd[2512]: time="2026-05-22T18:52:29.351021399Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 22 18:52:29.351944 containerd[2512]: time="2026-05-22T18:52:29.351033151Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 22 18:52:29.351944 containerd[2512]: time="2026-05-22T18:52:29.351045785Z" level=info msg="Connect containerd service" May 22 18:52:29.351944 containerd[2512]: time="2026-05-22T18:52:29.351071311Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 22 18:52:29.352190 containerd[2512]: time="2026-05-22T18:52:29.352163626Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" May 22 18:52:30.324764 containerd[2512]: time="2026-05-22T18:52:30.324697536Z" level=info msg="Start subscribing containerd event" May 22 18:52:30.325207 containerd[2512]: time="2026-05-22T18:52:30.325112551Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 22 18:52:30.325207 containerd[2512]: time="2026-05-22T18:52:30.325163814Z" level=info msg=serving... address=/run/containerd/containerd.sock May 22 18:52:30.325368 containerd[2512]: time="2026-05-22T18:52:30.325281687Z" level=info msg="Start recovering state" May 22 18:52:30.326758 containerd[2512]: time="2026-05-22T18:52:30.326376319Z" level=info msg="Start event monitor" May 22 18:52:30.326758 containerd[2512]: time="2026-05-22T18:52:30.326696924Z" level=info msg="Start cni network conf syncer for default" May 22 18:52:30.326758 containerd[2512]: time="2026-05-22T18:52:30.326707477Z" level=info msg="Start streaming server" May 22 18:52:30.326758 containerd[2512]: time="2026-05-22T18:52:30.326724463Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 22 18:52:30.326758 containerd[2512]: time="2026-05-22T18:52:30.326732809Z" level=info msg="runtime interface starting up..." May 22 18:52:30.327076 containerd[2512]: time="2026-05-22T18:52:30.326739880Z" level=info msg="starting plugins..." May 22 18:52:30.327076 containerd[2512]: time="2026-05-22T18:52:30.326963632Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 22 18:52:30.333290 containerd[2512]: time="2026-05-22T18:52:30.333034330Z" level=info msg="containerd successfully booted in 1.071133s" May 22 18:52:30.334400 systemd[1]: Started containerd.service - containerd container runtime. May 22 18:52:30.336561 systemd[1]: Reached target multi-user.target - Multi-User System. May 22 18:52:30.338480 systemd[1]: Startup finished in 4.523s (kernel) + 13.436s (initrd) + 17.774s (userspace) = 35.734s. May 22 18:52:30.982129 login[2614]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) May 22 18:52:31.036625 login[2615]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) May 22 18:52:31.064682 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 22 18:52:31.065968 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 22 18:52:31.069819 systemd-logind[2491]: New session '1' of user 'core' with class 'user-light' and type 'tty'. May 22 18:52:31.073287 systemd-logind[2491]: New session '2' of user 'core' with class 'user-light' and type 'tty'. May 22 18:52:31.098639 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 22 18:52:31.106960 systemd[1]: Started session-1.scope - Session 1 of User core. May 22 18:52:31.107508 systemd[1]: Started session-2.scope - Session 2 of User core. May 22 18:52:32.964141 waagent[2610]: 2026-05-22T18:52:32.964065Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 May 22 18:52:32.965667 waagent[2610]: 2026-05-22T18:52:32.965606Z INFO Daemon Daemon OS: flatcar 4694.0.1 May 22 18:52:32.966797 waagent[2610]: 2026-05-22T18:52:32.966717Z INFO Daemon Daemon Python: 3.12.12 May 22 18:52:32.968855 waagent[2610]: 2026-05-22T18:52:32.968120Z INFO Daemon Daemon Run daemon May 22 18:52:32.969506 waagent[2610]: 2026-05-22T18:52:32.969461Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4694.0.1' May 22 18:52:32.971390 waagent[2610]: 2026-05-22T18:52:32.971157Z INFO Daemon Daemon Using waagent for provisioning May 22 18:52:32.972480 waagent[2610]: 2026-05-22T18:52:32.972445Z INFO Daemon Daemon Activate resource disk May 22 18:52:32.973437 waagent[2610]: 2026-05-22T18:52:32.973238Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb May 22 18:52:32.976090 waagent[2610]: 2026-05-22T18:52:32.976056Z INFO Daemon Daemon Found device: None May 22 18:52:32.976978 waagent[2610]: 2026-05-22T18:52:32.976943Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology May 22 18:52:32.978322 waagent[2610]: 2026-05-22T18:52:32.978006Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 May 22 18:52:32.980532 waagent[2610]: 2026-05-22T18:52:32.980490Z INFO Daemon Daemon Clean protocol and wireserver endpoint May 22 18:52:32.981619 waagent[2610]: 2026-05-22T18:52:32.981552Z INFO Daemon Daemon Running default provisioning handler May 22 18:52:32.988233 waagent[2610]: 2026-05-22T18:52:32.988017Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 4. May 22 18:52:32.989319 waagent[2610]: 2026-05-22T18:52:32.989285Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' May 22 18:52:32.989430 waagent[2610]: 2026-05-22T18:52:32.989404Z INFO Daemon Daemon cloud-init is enabled: False May 22 18:52:32.989509 waagent[2610]: 2026-05-22T18:52:32.989490Z INFO Daemon Daemon Copying ovf-env.xml May 22 18:52:33.118227 waagent[2610]: 2026-05-22T18:52:33.117886Z INFO Daemon Daemon Successfully mounted dvd May 22 18:52:33.196375 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. May 22 18:52:33.197678 waagent[2610]: 2026-05-22T18:52:33.197554Z INFO Daemon Daemon Detect protocol endpoint May 22 18:52:33.197906 waagent[2610]: 2026-05-22T18:52:33.197875Z INFO Daemon Daemon Clean protocol and wireserver endpoint May 22 18:52:33.198145 waagent[2610]: 2026-05-22T18:52:33.198122Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler May 22 18:52:33.198412 waagent[2610]: 2026-05-22T18:52:33.198392Z INFO Daemon Daemon Test for route to 168.63.129.16 May 22 18:52:33.199072 waagent[2610]: 2026-05-22T18:52:33.199044Z INFO Daemon Daemon Route to 168.63.129.16 exists May 22 18:52:33.199269 waagent[2610]: 2026-05-22T18:52:33.199248Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 May 22 18:52:33.559976 waagent[2610]: 2026-05-22T18:52:33.559929Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 May 22 18:52:33.560687 waagent[2610]: 2026-05-22T18:52:33.560362Z INFO Daemon Daemon Wire protocol version:2012-11-30 May 22 18:52:33.560687 waagent[2610]: 2026-05-22T18:52:33.560449Z INFO Daemon Daemon Server preferred version:2015-04-05 May 22 18:52:33.650498 waagent[2610]: 2026-05-22T18:52:33.650411Z INFO Daemon Daemon Initializing goal state during protocol detection May 22 18:52:33.651179 waagent[2610]: 2026-05-22T18:52:33.650815Z INFO Daemon Daemon Forcing an update of the goal state. May 22 18:52:33.656159 waagent[2610]: 2026-05-22T18:52:33.656118Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] May 22 18:52:33.672669 waagent[2610]: 2026-05-22T18:52:33.672633Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.184 May 22 18:52:33.673946 waagent[2610]: 2026-05-22T18:52:33.673904Z INFO Daemon May 22 18:52:33.675110 waagent[2610]: 2026-05-22T18:52:33.674059Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: a770e582-e6da-4797-91ce-8f8082814a4c eTag: 1643780218216951541 source: Fabric] May 22 18:52:33.675110 waagent[2610]: 2026-05-22T18:52:33.674519Z INFO Daemon The vmSettings originated via Fabric; will ignore them. May 22 18:52:33.675110 waagent[2610]: 2026-05-22T18:52:33.674807Z INFO Daemon May 22 18:52:33.675110 waagent[2610]: 2026-05-22T18:52:33.674878Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] May 22 18:52:33.679374 waagent[2610]: 2026-05-22T18:52:33.679131Z INFO Daemon Daemon Downloading artifacts profile blob May 22 18:52:33.752623 waagent[2610]: 2026-05-22T18:52:33.752572Z INFO Daemon Downloaded certificate {'thumbprint': '750405E318DE2BE17819775E09713FB6D36ABD8D', 'hasPrivateKey': True} May 22 18:52:33.754916 waagent[2610]: 2026-05-22T18:52:33.754878Z INFO Daemon Fetch goal state completed May 22 18:52:33.762051 waagent[2610]: 2026-05-22T18:52:33.762005Z INFO Daemon Daemon Starting provisioning May 22 18:52:33.762928 waagent[2610]: 2026-05-22T18:52:33.762439Z INFO Daemon Daemon Handle ovf-env.xml. May 22 18:52:33.764030 waagent[2610]: 2026-05-22T18:52:33.763610Z INFO Daemon Daemon Set hostname [ci-4694.0.1-a-51b1c0bae6] May 22 18:52:33.779549 waagent[2610]: 2026-05-22T18:52:33.779509Z INFO Daemon Daemon Publish hostname [ci-4694.0.1-a-51b1c0bae6] May 22 18:52:33.784244 waagent[2610]: 2026-05-22T18:52:33.780154Z INFO Daemon Daemon Examine /proc/net/route for primary interface May 22 18:52:33.784244 waagent[2610]: 2026-05-22T18:52:33.780471Z INFO Daemon Daemon Primary interface is [eth0] May 22 18:52:33.787925 systemd-networkd[2237]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network May 22 18:52:33.787934 systemd-networkd[2237]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. May 22 18:52:33.787995 systemd-networkd[2237]: eth0: DHCP lease lost May 22 18:52:33.806872 waagent[2610]: 2026-05-22T18:52:33.801585Z INFO Daemon Daemon Create user account if not exists May 22 18:52:33.806872 waagent[2610]: 2026-05-22T18:52:33.801830Z INFO Daemon Daemon User core already exists, skip useradd May 22 18:52:33.806872 waagent[2610]: 2026-05-22T18:52:33.802024Z INFO Daemon Daemon Configure sudoer May 22 18:52:33.806872 waagent[2610]: 2026-05-22T18:52:33.802569Z INFO Daemon Daemon Configure sshd May 22 18:52:33.806872 waagent[2610]: 2026-05-22T18:52:33.802910Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. May 22 18:52:33.806872 waagent[2610]: 2026-05-22T18:52:33.803100Z INFO Daemon Daemon Deploy ssh public key. May 22 18:52:33.811811 systemd-networkd[2237]: eth0: DHCPv4 address 10.0.0.23/24, gateway 10.0.0.1 acquired from 168.63.129.16 May 22 18:52:34.896249 waagent[2610]: 2026-05-22T18:52:34.896192Z INFO Daemon Daemon Provisioning complete May 22 18:52:34.907104 waagent[2610]: 2026-05-22T18:52:34.907053Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping May 22 18:52:34.908024 waagent[2610]: 2026-05-22T18:52:34.907324Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. May 22 18:52:34.908024 waagent[2610]: 2026-05-22T18:52:34.907536Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent May 22 18:52:35.021454 waagent[2706]: 2026-05-22T18:52:35.021380Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) May 22 18:52:35.021797 waagent[2706]: 2026-05-22T18:52:35.021490Z INFO ExtHandler ExtHandler OS: flatcar 4694.0.1 May 22 18:52:35.021797 waagent[2706]: 2026-05-22T18:52:35.021544Z INFO ExtHandler ExtHandler Python: 3.12.12 May 22 18:52:35.021797 waagent[2706]: 2026-05-22T18:52:35.021586Z INFO ExtHandler ExtHandler CPU Arch: x86_64 May 22 18:52:35.057741 waagent[2706]: 2026-05-22T18:52:35.057691Z INFO ExtHandler ExtHandler Distro: flatcar-4694.0.1; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.12; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; May 22 18:52:35.057880 waagent[2706]: 2026-05-22T18:52:35.057856Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file May 22 18:52:35.057937 waagent[2706]: 2026-05-22T18:52:35.057919Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 May 22 18:52:35.065575 waagent[2706]: 2026-05-22T18:52:35.065517Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] May 22 18:52:35.075133 waagent[2706]: 2026-05-22T18:52:35.075104Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.184 May 22 18:52:35.075487 waagent[2706]: 2026-05-22T18:52:35.075455Z INFO ExtHandler May 22 18:52:35.075548 waagent[2706]: 2026-05-22T18:52:35.075524Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 5a7a565b-0b83-4d65-9093-93176bccc28e eTag: 1643780218216951541 source: Fabric] May 22 18:52:35.075796 waagent[2706]: 2026-05-22T18:52:35.075772Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. May 22 18:52:35.076162 waagent[2706]: 2026-05-22T18:52:35.076137Z INFO ExtHandler May 22 18:52:35.076203 waagent[2706]: 2026-05-22T18:52:35.076189Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] May 22 18:52:35.080588 waagent[2706]: 2026-05-22T18:52:35.080560Z INFO ExtHandler ExtHandler Downloading artifacts profile blob May 22 18:52:35.145442 waagent[2706]: 2026-05-22T18:52:35.145389Z INFO ExtHandler Downloaded certificate {'thumbprint': '750405E318DE2BE17819775E09713FB6D36ABD8D', 'hasPrivateKey': True} May 22 18:52:35.145819 waagent[2706]: 2026-05-22T18:52:35.145785Z INFO ExtHandler Fetch goal state completed May 22 18:52:35.162126 waagent[2706]: 2026-05-22T18:52:35.162049Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.5 27 Jan 2026 (Library: OpenSSL 3.5.5 27 Jan 2026) May 22 18:52:35.165224 waagent[2706]: 2026-05-22T18:52:35.165178Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2706 May 22 18:52:35.165348 waagent[2706]: 2026-05-22T18:52:35.165322Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** May 22 18:52:35.165601 waagent[2706]: 2026-05-22T18:52:35.165577Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** May 22 18:52:35.166724 waagent[2706]: 2026-05-22T18:52:35.166654Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4694.0.1', '', 'Flatcar Container Linux by Kinvolk'] May 22 18:52:35.167023 waagent[2706]: 2026-05-22T18:52:35.166998Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4694.0.1', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported May 22 18:52:35.167126 waagent[2706]: 2026-05-22T18:52:35.167104Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False May 22 18:52:35.167543 waagent[2706]: 2026-05-22T18:52:35.167516Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules May 22 18:52:35.202675 waagent[2706]: 2026-05-22T18:52:35.202636Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service May 22 18:52:35.202826 waagent[2706]: 2026-05-22T18:52:35.202803Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup May 22 18:52:35.208551 waagent[2706]: 2026-05-22T18:52:35.208195Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now May 22 18:52:35.213506 systemd[1]: Reload requested from client PID 2721 ('systemctl') (unit waagent.service)... May 22 18:52:35.213522 systemd[1]: Reloading... May 22 18:52:35.288715 zram_generator::config[2770]: No configuration found. May 22 18:52:35.310722 systemd-ssh-generator[2765]: Failed to query local AF_VSOCK CID: Cannot assign requested address May 22 18:52:35.313117 (sd-exec-[2747]: /usr/lib/systemd/system-generators/systemd-ssh-generator failed with exit status 1. May 22 18:52:35.521051 systemd[1]: Reloading finished in 307 ms. May 22 18:52:35.543680 waagent[2706]: 2026-05-22T18:52:35.543067Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service May 22 18:52:35.543680 waagent[2706]: 2026-05-22T18:52:35.543226Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully May 22 18:52:35.926490 waagent[2706]: 2026-05-22T18:52:35.926427Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. May 22 18:52:35.926802 waagent[2706]: 2026-05-22T18:52:35.926774Z INFO ExtHandler ExtHandler Checking if log collection is allowed at this time [False]. All three conditions must be met: 1. configuration enabled [True], 2. cgroups v1 enabled [False] OR cgroups v2 is in use and v2 resource limiting configuration enabled [False], 3. python supported: [True] May 22 18:52:35.927478 waagent[2706]: 2026-05-22T18:52:35.927429Z INFO ExtHandler ExtHandler Starting env monitor service. May 22 18:52:35.928041 waagent[2706]: 2026-05-22T18:52:35.928008Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. May 22 18:52:35.928255 waagent[2706]: 2026-05-22T18:52:35.928223Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread May 22 18:52:35.928306 waagent[2706]: 2026-05-22T18:52:35.928279Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file May 22 18:52:35.928371 waagent[2706]: 2026-05-22T18:52:35.928353Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 May 22 18:52:35.928572 waagent[2706]: 2026-05-22T18:52:35.928550Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. May 22 18:52:35.928747 waagent[2706]: 2026-05-22T18:52:35.928721Z INFO ExtHandler ExtHandler Start Extension Telemetry service. May 22 18:52:35.928947 waagent[2706]: 2026-05-22T18:52:35.928915Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True May 22 18:52:35.929011 waagent[2706]: 2026-05-22T18:52:35.928980Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file May 22 18:52:35.929077 waagent[2706]: 2026-05-22T18:52:35.929056Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 May 22 18:52:35.929228 waagent[2706]: 2026-05-22T18:52:35.929206Z INFO EnvHandler ExtHandler Configure routes May 22 18:52:35.929296 waagent[2706]: 2026-05-22T18:52:35.929263Z INFO EnvHandler ExtHandler Gateway:None May 22 18:52:35.929345 waagent[2706]: 2026-05-22T18:52:35.929326Z INFO EnvHandler ExtHandler Routes:None May 22 18:52:35.929578 waagent[2706]: 2026-05-22T18:52:35.929535Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. May 22 18:52:35.930245 waagent[2706]: 2026-05-22T18:52:35.930221Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: May 22 18:52:35.930245 waagent[2706]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT May 22 18:52:35.930245 waagent[2706]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 May 22 18:52:35.930245 waagent[2706]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 May 22 18:52:35.930245 waagent[2706]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 May 22 18:52:35.930245 waagent[2706]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 May 22 18:52:35.930245 waagent[2706]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 May 22 18:52:35.930417 waagent[2706]: 2026-05-22T18:52:35.930317Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread May 22 18:52:35.943153 waagent[2706]: 2026-05-22T18:52:35.943110Z INFO ExtHandler ExtHandler May 22 18:52:35.943215 waagent[2706]: 2026-05-22T18:52:35.943185Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 72d9dbbc-e16a-4df5-b983-feac6105b5f2 correlation 71ebea3e-9d17-443f-97db-d26efe2ee361 created: 2026-05-22T18:51:31.684425Z] May 22 18:52:35.943474 waagent[2706]: 2026-05-22T18:52:35.943447Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. May 22 18:52:35.943937 waagent[2706]: 2026-05-22T18:52:35.943913Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] May 22 18:52:35.970936 waagent[2706]: 2026-05-22T18:52:35.970894Z WARNING ExtHandler ExtHandler Failed to get firewall packets: 'iptables -w -t security -L OUTPUT --zero OUTPUT -nxv' failed: 2 (iptables v1.8.11 (nf_tables): Illegal option `--numeric' with this command May 22 18:52:35.970936 waagent[2706]: Try `iptables -h' or 'iptables --help' for more information.) May 22 18:52:35.971243 waagent[2706]: 2026-05-22T18:52:35.971214Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 6D8CAD80-C1FC-4F16-9A09-1B65F298C909;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] May 22 18:52:36.005789 waagent[2706]: 2026-05-22T18:52:36.005748Z INFO MonitorHandler ExtHandler Network interfaces: May 22 18:52:36.005789 waagent[2706]: Executing ['ip', '-a', '-o', 'link']: May 22 18:52:36.005789 waagent[2706]: 1: lo: mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\ link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 May 22 18:52:36.005789 waagent[2706]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 60:45:bd:c1:8d:e3 brd ff:ff:ff:ff:ff:ff\ alias Network Device\ altname enx6045bdc18de3 May 22 18:52:36.005789 waagent[2706]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 60:45:bd:c1:8d:e3 brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0\ altname enp0s0\ altname ens1 May 22 18:52:36.005789 waagent[2706]: Executing ['ip', '-4', '-a', '-o', 'address']: May 22 18:52:36.005789 waagent[2706]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever May 22 18:52:36.005789 waagent[2706]: 2: eth0 inet 10.0.0.23/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever May 22 18:52:36.005789 waagent[2706]: Executing ['ip', '-6', '-a', '-o', 'address']: May 22 18:52:36.005789 waagent[2706]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever May 22 18:52:36.005789 waagent[2706]: 2: eth0 inet6 fe80::6245:bdff:fec1:8de3/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever May 22 18:52:36.030789 waagent[2706]: 2026-05-22T18:52:36.030741Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: May 22 18:52:36.030789 waagent[2706]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) May 22 18:52:36.030789 waagent[2706]: pkts bytes target prot opt in out source destination May 22 18:52:36.030789 waagent[2706]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) May 22 18:52:36.030789 waagent[2706]: pkts bytes target prot opt in out source destination May 22 18:52:36.030789 waagent[2706]: Chain OUTPUT (policy ACCEPT 1 packets, 60 bytes) May 22 18:52:36.030789 waagent[2706]: pkts bytes target prot opt in out source destination May 22 18:52:36.030789 waagent[2706]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 May 22 18:52:36.030789 waagent[2706]: 9 874 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 May 22 18:52:36.030789 waagent[2706]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW May 22 18:52:36.034056 waagent[2706]: 2026-05-22T18:52:36.034011Z INFO EnvHandler ExtHandler Current Firewall rules: May 22 18:52:36.034056 waagent[2706]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) May 22 18:52:36.034056 waagent[2706]: pkts bytes target prot opt in out source destination May 22 18:52:36.034056 waagent[2706]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) May 22 18:52:36.034056 waagent[2706]: pkts bytes target prot opt in out source destination May 22 18:52:36.034056 waagent[2706]: Chain OUTPUT (policy ACCEPT 1 packets, 60 bytes) May 22 18:52:36.034056 waagent[2706]: pkts bytes target prot opt in out source destination May 22 18:52:36.034056 waagent[2706]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 May 22 18:52:36.034056 waagent[2706]: 12 1408 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 May 22 18:52:36.034056 waagent[2706]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW May 22 18:52:47.863973 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 22 18:52:47.865071 systemd[1]: Started sshd@0-1-10.0.0.23:22-4.175.71.9:53774.service - OpenSSH per-connection server daemon (4.175.71.9:53774). May 22 18:52:48.113532 sshd[2862]: Accepted publickey for core from 4.175.71.9 port 53774 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:52:48.114559 sshd-session[2862]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:52:48.127736 systemd[1]: Starting user@500.service - User Manager for UID 500... May 22 18:52:48.130813 systemd-logind[2491]: New session '3' of user 'core' with class 'user' and type 'tty'. May 22 18:52:48.137240 (systemd)[2866]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) May 22 18:52:48.139045 systemd-logind[2491]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. May 22 18:52:48.314003 systemd[2866]: Queued start job for default target default.target. May 22 18:52:48.320412 systemd[2866]: Created slice app.slice - User Application Slice. May 22 18:52:48.320444 systemd[2866]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. May 22 18:52:48.320460 systemd[2866]: Reached target machines.target - Virtual Machines and Containers. May 22 18:52:48.320500 systemd[2866]: Reached target paths.target - Paths. May 22 18:52:48.320523 systemd[2866]: Reached target timers.target - Timers. May 22 18:52:48.321507 systemd[2866]: Starting dbus.socket - D-Bus User Message Bus Socket... May 22 18:52:48.322892 systemd[2866]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. May 22 18:52:48.323697 systemd[2866]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... May 22 18:52:48.340112 systemd[2866]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. May 22 18:52:48.340370 systemd[2866]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 22 18:52:48.340544 systemd[2866]: Reached target sockets.target - Sockets. May 22 18:52:48.340643 systemd[2866]: Reached target basic.target - Basic System. May 22 18:52:48.340740 systemd[2866]: Reached target default.target - Main User Target. May 22 18:52:48.340819 systemd[2866]: Startup finished in 197ms. May 22 18:52:48.340885 systemd[1]: Started user@500.service - User Manager for UID 500. May 22 18:52:48.347832 systemd[1]: Started session-3.scope - Session 3 of User core. May 22 18:52:48.390786 systemd[1]: Started sshd@1-2-10.0.0.23:22-4.175.71.9:53782.service - OpenSSH per-connection server daemon (4.175.71.9:53782). May 22 18:52:48.473304 sshd[2880]: Accepted publickey for core from 4.175.71.9 port 53782 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:52:48.474517 sshd-session[2880]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:52:48.478749 systemd-logind[2491]: New session '5' of user 'core' with class 'user' and type 'tty'. May 22 18:52:48.484822 systemd[1]: Started session-5.scope - Session 5 of User core. May 22 18:52:48.510089 sshd[2884]: Connection closed by 4.175.71.9 port 53782 May 22 18:52:48.510505 sshd-session[2880]: pam_unix(sshd:session): session closed for user core May 22 18:52:48.513101 systemd[1]: sshd@1-2-10.0.0.23:22-4.175.71.9:53782.service: Deactivated successfully. May 22 18:52:48.514468 systemd[1]: session-5.scope: Deactivated successfully. May 22 18:52:48.515136 systemd-logind[2491]: Session 5 logged out. Waiting for processes to exit. May 22 18:52:48.516275 systemd-logind[2491]: Removed session 5. May 22 18:52:48.531023 systemd[1]: Started sshd@2-3-10.0.0.23:22-4.175.71.9:53792.service - OpenSSH per-connection server daemon (4.175.71.9:53792). May 22 18:52:48.608500 sshd[2890]: Accepted publickey for core from 4.175.71.9 port 53792 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:52:48.609524 sshd-session[2890]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:52:48.612749 systemd-logind[2491]: New session '6' of user 'core' with class 'user' and type 'tty'. May 22 18:52:48.618810 systemd[1]: Started session-6.scope - Session 6 of User core. May 22 18:52:48.640050 sshd[2894]: Connection closed by 4.175.71.9 port 53792 May 22 18:52:48.640798 sshd-session[2890]: pam_unix(sshd:session): session closed for user core May 22 18:52:48.643422 systemd[1]: sshd@2-3-10.0.0.23:22-4.175.71.9:53792.service: Deactivated successfully. May 22 18:52:48.645262 systemd[1]: session-6.scope: Deactivated successfully. May 22 18:52:48.645968 systemd-logind[2491]: Session 6 logged out. Waiting for processes to exit. May 22 18:52:48.647267 systemd-logind[2491]: Removed session 6. May 22 18:52:48.657949 systemd[1]: Started sshd@3-4-10.0.0.23:22-4.175.71.9:53802.service - OpenSSH per-connection server daemon (4.175.71.9:53802). May 22 18:52:48.749139 sshd[2901]: Accepted publickey for core from 4.175.71.9 port 53802 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:52:48.750138 sshd-session[2901]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:52:48.754148 systemd-logind[2491]: New session '7' of user 'core' with class 'user' and type 'tty'. May 22 18:52:48.756812 systemd[1]: Started session-7.scope - Session 7 of User core. May 22 18:52:48.783860 sshd[2905]: Connection closed by 4.175.71.9 port 53802 May 22 18:52:48.785233 sshd-session[2901]: pam_unix(sshd:session): session closed for user core May 22 18:52:48.787338 systemd[1]: sshd@3-4-10.0.0.23:22-4.175.71.9:53802.service: Deactivated successfully. May 22 18:52:48.788680 systemd[1]: session-7.scope: Deactivated successfully. May 22 18:52:48.789364 systemd-logind[2491]: Session 7 logged out. Waiting for processes to exit. May 22 18:52:48.790458 systemd-logind[2491]: Removed session 7. May 22 18:52:48.802011 systemd[1]: Started sshd@4-5-10.0.0.23:22-4.175.71.9:53812.service - OpenSSH per-connection server daemon (4.175.71.9:53812). May 22 18:52:48.880228 sshd[2911]: Accepted publickey for core from 4.175.71.9 port 53812 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:52:48.881241 sshd-session[2911]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:52:48.885273 systemd-logind[2491]: New session '8' of user 'core' with class 'user' and type 'tty'. May 22 18:52:48.894806 systemd[1]: Started session-8.scope - Session 8 of User core. May 22 18:52:49.092187 sudo[2916]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 22 18:52:49.092439 sudo[2916]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 22 18:52:49.105527 sudo[2916]: pam_unix(sudo:session): session closed for user root May 22 18:52:49.114567 sshd[2915]: Connection closed by 4.175.71.9 port 53812 May 22 18:52:49.115897 sshd-session[2911]: pam_unix(sshd:session): session closed for user core May 22 18:52:49.118616 systemd[1]: sshd@4-5-10.0.0.23:22-4.175.71.9:53812.service: Deactivated successfully. May 22 18:52:49.120267 systemd[1]: session-8.scope: Deactivated successfully. May 22 18:52:49.121072 systemd-logind[2491]: Session 8 logged out. Waiting for processes to exit. May 22 18:52:49.127512 systemd[1]: Started sshd@5-6-10.0.0.23:22-4.175.71.9:53828.service - OpenSSH per-connection server daemon (4.175.71.9:53828). May 22 18:52:49.128758 systemd-logind[2491]: Removed session 8. May 22 18:52:49.203703 sshd[2923]: Accepted publickey for core from 4.175.71.9 port 53828 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:52:49.204606 sshd-session[2923]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:52:49.208675 systemd-logind[2491]: New session '9' of user 'core' with class 'user' and type 'tty'. May 22 18:52:49.213840 systemd[1]: Started session-9.scope - Session 9 of User core. May 22 18:52:49.231883 sudo[2929]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules May 22 18:52:49.232305 sudo[2929]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 22 18:52:49.233613 sudo[2929]: pam_unix(sudo:session): session closed for user root May 22 18:52:49.239481 sudo[2928]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 22 18:52:49.239650 sudo[2928]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 22 18:52:49.245695 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 22 18:52:49.274000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 May 22 18:52:49.276809 augenrules[2953]: No rules May 22 18:52:49.277320 kernel: kauditd_printk_skb: 85 callbacks suppressed May 22 18:52:49.277361 kernel: audit: type=1305 audit(1779475969.274:179): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 May 22 18:52:49.279265 systemd[1]: audit-rules.service: Deactivated successfully. May 22 18:52:49.279493 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 22 18:52:49.274000 audit[2953]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff4c828b00 a2=420 a3=0 items=0 ppid=2934 pid=2953 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) May 22 18:52:49.280817 sudo[2928]: pam_unix(sudo:session): session closed for user root May 22 18:52:49.274000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 May 22 18:52:49.278000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:49.286178 kernel: audit: type=1300 audit(1779475969.274:179): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff4c828b00 a2=420 a3=0 items=0 ppid=2934 pid=2953 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) May 22 18:52:49.286259 kernel: audit: type=1327 audit(1779475969.274:179): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 May 22 18:52:49.286276 kernel: audit: type=1130 audit(1779475969.278:180): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:49.278000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:49.279000 audit[2928]: AUDIT1106 pid=2928 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' May 22 18:52:49.290981 kernel: audit: type=1131 audit(1779475969.278:181): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:49.290037 sshd-session[2923]: pam_unix(sshd:session): session closed for user core May 22 18:52:49.291286 sshd[2927]: Connection closed by 4.175.71.9 port 53828 May 22 18:52:49.291925 kernel: audit: type=1106 audit(1779475969.279:182): pid=2928 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' May 22 18:52:49.279000 audit[2928]: AUDIT1104 pid=2928 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' May 22 18:52:49.295686 kernel: audit: type=1104 audit(1779475969.279:183): pid=2928 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' May 22 18:52:49.291000 audit[2923]: AUDIT1106 pid=2923 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' May 22 18:52:49.301812 kernel: audit: type=1106 audit(1779475969.291:184): pid=2923 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' May 22 18:52:49.296398 systemd[1]: sshd@5-6-10.0.0.23:22-4.175.71.9:53828.service: Deactivated successfully. May 22 18:52:49.298461 systemd[1]: session-9.scope: Deactivated successfully. May 22 18:52:49.299296 systemd-logind[2491]: Session 9 logged out. Waiting for processes to exit. May 22 18:52:49.291000 audit[2923]: AUDIT1104 pid=2923 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' May 22 18:52:49.294000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-6-10.0.0.23:22-4.175.71.9:53828 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:49.308849 kernel: audit: type=1104 audit(1779475969.291:185): pid=2923 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' May 22 18:52:49.308881 kernel: audit: type=1131 audit(1779475969.294:186): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-6-10.0.0.23:22-4.175.71.9:53828 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:49.313678 systemd-logind[2491]: Removed session 9. May 22 18:52:49.314915 systemd[1]: Started sshd@6-7-10.0.0.23:22-4.175.71.9:53834.service - OpenSSH per-connection server daemon (4.175.71.9:53834). May 22 18:52:49.313000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-7-10.0.0.23:22-4.175.71.9:53834 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:49.389000 audit[2962]: AUDIT1101 pid=2962 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_time,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' May 22 18:52:49.391364 sshd[2962]: Accepted publickey for core from 4.175.71.9 port 53834 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:52:49.390000 audit[2962]: AUDIT1103 pid=2962 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/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' May 22 18:52:49.390000 audit[2962]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7ffe36404f00 a2=3 a3=0 items=0 ppid=1 pid=2962 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=10 comm="sshd-session" exe="/usr/lib64/misc/sshd-session" subj=system_u:system_r:kernel_t:s0 key=(null) May 22 18:52:49.390000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D May 22 18:52:49.392493 sshd-session[2962]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:52:49.396890 systemd-logind[2491]: New session '10' of user 'core' with class 'user' and type 'tty'. May 22 18:52:49.406875 systemd[1]: Started session-10.scope - Session 10 of User core. May 22 18:52:49.407000 audit[2962]: AUDIT1105 pid=2962 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' May 22 18:52:49.409000 audit[2966]: AUDIT1103 pid=2966 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' May 22 18:52:49.434189 sshd[2966]: Connection closed by 4.175.71.9 port 53834 May 22 18:52:49.434793 sshd-session[2962]: pam_unix(sshd:session): session closed for user core May 22 18:52:49.433000 audit[2962]: AUDIT1106 pid=2962 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' May 22 18:52:49.433000 audit[2962]: AUDIT1104 pid=2962 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' May 22 18:52:49.436790 systemd[1]: sshd@6-7-10.0.0.23:22-4.175.71.9:53834.service: Deactivated successfully. May 22 18:52:49.435000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-7-10.0.0.23:22-4.175.71.9:53834 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:52:49.438146 systemd[1]: session-10.scope: Deactivated successfully. May 22 18:52:49.439754 systemd-logind[2491]: Session 10 logged out. Waiting for processes to exit. May 22 18:52:49.440384 systemd-logind[2491]: Removed session 10. May 22 18:52:50.882612 chronyd[2475]: Selected source PHC0