May 22 18:56:34.734221 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:56:34.734282 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:56:34.734298 kernel: BIOS-provided physical RAM map: May 22 18:56:34.734308 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable May 22 18:56:34.734320 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved May 22 18:56:34.734330 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000044fdfff] usable May 22 18:56:34.734342 kernel: BIOS-e820: [mem 0x00000000044fe000-0x00000000048fdfff] reserved May 22 18:56:34.734349 kernel: BIOS-e820: [mem 0x00000000048fe000-0x000000003ff1efff] usable May 22 18:56:34.734359 kernel: BIOS-e820: [mem 0x000000003ff1f000-0x000000003ffc8fff] reserved May 22 18:56:34.734368 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data May 22 18:56:34.734378 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS May 22 18:56:34.734389 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable May 22 18:56:34.734396 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable May 22 18:56:34.734408 kernel: printk: legacy bootconsole [earlyser0] enabled May 22 18:56:34.734421 kernel: NX (Execute Disable) protection: active May 22 18:56:34.734428 kernel: APIC: Static calls initialized May 22 18:56:34.734438 kernel: efi: EFI v2.7 by Microsoft May 22 18:56:34.734450 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff88000 SMBIOS 3.0=0x3ff86000 MEMATTR=0x3ea91018 RNG=0x3ffd2018 May 22 18:56:34.734461 kernel: random: crng init done May 22 18:56:34.734472 kernel: secureboot: Secure boot disabled May 22 18:56:34.734482 kernel: SMBIOS 3.1.0 present. May 22 18:56:34.734493 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 01/08/2026 May 22 18:56:34.734500 kernel: DMI: Memory slots populated: 2/2 May 22 18:56:34.734508 kernel: Hypervisor detected: Microsoft Hyper-V May 22 18:56:34.734523 kernel: Hyper-V: privilege flags low 0xae7f, high 0x3b8030, hints 0x9e4e24, misc 0xe0bed7b2 May 22 18:56:34.734530 kernel: Hyper-V: Nested features: 0x3e0101 May 22 18:56:34.734541 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 May 22 18:56:34.734552 kernel: Hyper-V: Using hypercall for remote TLB flush May 22 18:56:34.734562 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns May 22 18:56:34.734573 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns May 22 18:56:34.734583 kernel: tsc: Detected 2299.998 MHz processor May 22 18:56:34.734593 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved May 22 18:56:34.734610 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable May 22 18:56:34.734627 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x10000000000 May 22 18:56:34.734641 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs May 22 18:56:34.734657 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT May 22 18:56:34.734672 kernel: e820: update [mem 0x48000000-0xffffffff] usable ==> reserved May 22 18:56:34.734683 kernel: last_pfn = 0x40000 max_arch_pfn = 0x10000000000 May 22 18:56:34.734694 kernel: Using GB pages for direct mapping May 22 18:56:34.734708 kernel: ACPI: Early table checksum verification disabled May 22 18:56:34.734723 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) May 22 18:56:34.734742 kernel: ACPI: XSDT 0x000000003FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:56:34.734756 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:56:34.734772 kernel: ACPI: DSDT 0x000000003FFD6000 01E22B (v02 MSFTVM DSDT01 00000001 INTL 20230628) May 22 18:56:34.734787 kernel: ACPI: FACS 0x000000003FFFE000 000040 May 22 18:56:34.734802 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:56:34.734819 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:56:34.734834 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:56:34.734843 kernel: ACPI: APIC 0x000000003FFD5000 000058 (v05 HVLITE HVLITETB 00000000 MSHV 00000000) May 22 18:56:34.734857 kernel: ACPI: SRAT 0x000000003FFD4000 0000A0 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) May 22 18:56:34.734872 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 22 18:56:34.734881 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] May 22 18:56:34.734890 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff422a] May 22 18:56:34.734901 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] May 22 18:56:34.734937 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] May 22 18:56:34.734946 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] May 22 18:56:34.734958 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] May 22 18:56:34.734968 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5057] May 22 18:56:34.734982 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd409f] May 22 18:56:34.734990 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] May 22 18:56:34.735002 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] May 22 18:56:34.735015 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] May 22 18:56:34.735025 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00001000-0x2bfffffff] May 22 18:56:34.735034 kernel: NODE_DATA(0) allocated [mem 0x2bfff8dc0-0x2bfffffff] May 22 18:56:34.735051 kernel: Zone ranges: May 22 18:56:34.735062 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] May 22 18:56:34.735070 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] May 22 18:56:34.735085 kernel: Normal [mem 0x0000000100000000-0x00000002bfffffff] May 22 18:56:34.735101 kernel: Device empty May 22 18:56:34.735110 kernel: Movable zone start for each node May 22 18:56:34.735122 kernel: Early memory node ranges May 22 18:56:34.735134 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] May 22 18:56:34.735142 kernel: node 0: [mem 0x0000000000100000-0x00000000044fdfff] May 22 18:56:34.735154 kernel: node 0: [mem 0x00000000048fe000-0x000000003ff1efff] May 22 18:56:34.735163 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] May 22 18:56:34.735174 kernel: node 0: [mem 0x0000000100000000-0x00000002bfffffff] May 22 18:56:34.735188 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff] May 22 18:56:34.735200 kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 22 18:56:34.735209 kernel: On node 0, zone DMA: 96 pages in unavailable ranges May 22 18:56:34.735220 kernel: On node 0, zone DMA32: 1024 pages in unavailable ranges May 22 18:56:34.735229 kernel: On node 0, zone DMA32: 224 pages in unavailable ranges May 22 18:56:34.735238 kernel: ACPI: PM-Timer IO Port: 0x408 May 22 18:56:34.735247 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) May 22 18:56:34.735258 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 May 22 18:56:34.735272 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) May 22 18:56:34.735284 kernel: ACPI: Using ACPI (MADT) for SMP configuration information May 22 18:56:34.735293 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 May 22 18:56:34.735302 kernel: TSC deadline timer available May 22 18:56:34.735311 kernel: CPU topo: Max. logical packages: 1 May 22 18:56:34.735326 kernel: CPU topo: Max. logical dies: 1 May 22 18:56:34.735339 kernel: CPU topo: Max. dies per package: 1 May 22 18:56:34.735353 kernel: CPU topo: Max. threads per core: 2 May 22 18:56:34.735362 kernel: CPU topo: Num. cores per package: 1 May 22 18:56:34.735371 kernel: CPU topo: Num. threads per package: 2 May 22 18:56:34.735383 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs May 22 18:56:34.735397 kernel: [mem 0x40000000-0xffffffff] available for PCI devices May 22 18:56:34.735406 kernel: Booting paravirtualized kernel on Hyper-V May 22 18:56:34.735420 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns May 22 18:56:34.735429 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 May 22 18:56:34.735437 kernel: percpu: Embedded 60 pages/cpu s208408 r8192 d29160 u1048576 May 22 18:56:34.735445 kernel: pcpu-alloc: s208408 r8192 d29160 u1048576 alloc=1*2097152 May 22 18:56:34.735457 kernel: pcpu-alloc: [0] 0 1 May 22 18:56:34.735465 kernel: Hyper-V: PV spinlocks enabled May 22 18:56:34.735473 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) May 22 18:56:34.735488 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:56:34.735500 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) May 22 18:56:34.735511 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 22 18:56:34.735519 kernel: Fallback order for Node 0: 0 May 22 18:56:34.735530 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2095807 May 22 18:56:34.735541 kernel: Policy zone: Normal May 22 18:56:34.735549 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 22 18:56:34.735559 kernel: software IO TLB: area num 2. May 22 18:56:34.735567 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 May 22 18:56:34.735576 kernel: ftrace: allocating 41958 entries in 164 pages May 22 18:56:34.735584 kernel: ftrace: allocated 164 pages with 3 groups May 22 18:56:34.735593 kernel: Dynamic Preempt: voluntary May 22 18:56:34.735601 kernel: rcu: Preemptible hierarchical RCU implementation. May 22 18:56:34.735611 kernel: rcu: RCU event tracing is enabled. May 22 18:56:34.735632 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. May 22 18:56:34.735644 kernel: Trampoline variant of Tasks RCU enabled. May 22 18:56:34.735655 kernel: Rude variant of Tasks RCU enabled. May 22 18:56:34.735669 kernel: Tracing variant of Tasks RCU enabled. May 22 18:56:34.735678 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 22 18:56:34.735687 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 May 22 18:56:34.735696 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 22 18:56:34.735705 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:56:34.735715 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:56:34.735726 kernel: Using NULL legacy PIC May 22 18:56:34.735735 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0 May 22 18:56:34.735747 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 22 18:56:34.735756 kernel: Console: colour dummy device 80x25 May 22 18:56:34.735767 kernel: printk: legacy console [tty1] enabled May 22 18:56:34.735776 kernel: printk: legacy console [ttyS0] enabled May 22 18:56:34.735785 kernel: printk: legacy bootconsole [earlyser0] disabled May 22 18:56:34.735795 kernel: ACPI: Core revision 20240827 May 22 18:56:34.735805 kernel: Failed to register legacy timer interrupt May 22 18:56:34.735814 kernel: APIC: Switch to symmetric I/O mode setup May 22 18:56:34.735823 kernel: x2apic enabled May 22 18:56:34.735834 kernel: APIC: Switched APIC routing to: physical x2apic May 22 18:56:34.735843 kernel: Hyper-V: Host Build 10.0.26102.1310-1-0 May 22 18:56:34.735852 kernel: Hyper-V: enabling crash_kexec_post_notifiers May 22 18:56:34.735861 kernel: Hyper-V: Disabling IBT because of Hyper-V bug May 22 18:56:34.735874 kernel: Hyper-V: Using IPI hypercalls May 22 18:56:34.735883 kernel: APIC: send_IPI() replaced with hv_send_ipi() May 22 18:56:34.735892 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() May 22 18:56:34.735903 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() May 22 18:56:34.735913 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() May 22 18:56:34.735943 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() May 22 18:56:34.735952 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() May 22 18:56:34.738159 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212733415c7, max_idle_ns: 440795236380 ns May 22 18:56:34.738179 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4599.99 BogoMIPS (lpj=2299998) May 22 18:56:34.738190 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated May 22 18:56:34.738205 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 May 22 18:56:34.738215 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 May 22 18:56:34.738225 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization May 22 18:56:34.738234 kernel: Spectre V2 : Mitigation: Retpolines May 22 18:56:34.738243 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT May 22 18:56:34.738256 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! May 22 18:56:34.738266 kernel: RETBleed: Vulnerable May 22 18:56:34.738275 kernel: Speculative Store Bypass: Vulnerable May 22 18:56:34.738284 kernel: active return thunk: its_return_thunk May 22 18:56:34.738292 kernel: ITS: Mitigation: Aligned branch/return thunks May 22 18:56:34.738303 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' May 22 18:56:34.738313 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' May 22 18:56:34.738322 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' May 22 18:56:34.738331 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' May 22 18:56:34.738340 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' May 22 18:56:34.738350 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' May 22 18:56:34.738359 kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' May 22 18:56:34.738368 kernel: x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' May 22 18:56:34.738378 kernel: x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' May 22 18:56:34.738387 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 May 22 18:56:34.738398 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 May 22 18:56:34.738407 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 May 22 18:56:34.738416 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 May 22 18:56:34.738424 kernel: x86/fpu: xstate_offset[11]: 2432, xstate_sizes[11]: 16 May 22 18:56:34.738433 kernel: x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 May 22 18:56:34.738443 kernel: x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 May 22 18:56:34.738452 kernel: x86/fpu: Enabled xstate features 0x608e7, context size is 10752 bytes, using 'compacted' format. May 22 18:56:34.738461 kernel: Freeing SMP alternatives memory: 36K May 22 18:56:34.738469 kernel: pid_max: default: 32768 minimum: 301 May 22 18:56:34.738478 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima May 22 18:56:34.738487 kernel: landlock: Up and running. May 22 18:56:34.738498 kernel: SELinux: Initializing. May 22 18:56:34.738508 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) May 22 18:56:34.738518 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) May 22 18:56:34.738527 kernel: smpboot: CPU0: Intel INTEL(R) XEON(R) PLATINUM 8573C (family: 0x6, model: 0xcf, stepping: 0x2) May 22 18:56:34.738537 kernel: Performance Events: unsupported p6 CPU model 207 no PMU driver, software events only. May 22 18:56:34.738546 kernel: signal: max sigframe size: 11952 May 22 18:56:34.738556 kernel: rcu: Hierarchical SRCU implementation. May 22 18:56:34.738566 kernel: rcu: Max phase no-delay instances is 400. May 22 18:56:34.738580 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level May 22 18:56:34.738590 kernel: NMI watchdog: Perf NMI watchdog permanently disabled May 22 18:56:34.738599 kernel: smp: Bringing up secondary CPUs ... May 22 18:56:34.738609 kernel: smpboot: x86: Booting SMP configuration: May 22 18:56:34.738619 kernel: .... node #0, CPUs: #1 May 22 18:56:34.738631 kernel: smp: Brought up 1 node, 2 CPUs May 22 18:56:34.738644 kernel: smpboot: Total of 2 processors activated (9199.99 BogoMIPS) May 22 18:56:34.738654 kernel: Memory: 8058740K/8383228K available (14336K kernel code, 2475K rwdata, 32160K rodata, 15988K init, 2068K bss, 318228K reserved, 0K cma-reserved) May 22 18:56:34.738666 kernel: devtmpfs: initialized May 22 18:56:34.738675 kernel: x86/mm: Memory block size: 128MB May 22 18:56:34.738684 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) May 22 18:56:34.738694 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 22 18:56:34.738703 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) May 22 18:56:34.738713 kernel: pinctrl core: initialized pinctrl subsystem May 22 18:56:34.738722 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 22 18:56:34.738733 kernel: audit: initializing netlink subsys (disabled) May 22 18:56:34.738743 kernel: audit: type=2000 audit(1779476188.081:1): state=initialized audit_enabled=0 res=1 May 22 18:56:34.738753 kernel: thermal_sys: Registered thermal governor 'step_wise' May 22 18:56:34.738763 kernel: thermal_sys: Registered thermal governor 'user_space' May 22 18:56:34.738773 kernel: cpuidle: using governor menu May 22 18:56:34.738786 kernel: efi: Freeing EFI boot services memory: 34628K May 22 18:56:34.738796 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 22 18:56:34.738811 kernel: dca service started, version 1.12.1 May 22 18:56:34.738824 kernel: e820: reserve RAM buffer [mem 0x044fe000-0x07ffffff] May 22 18:56:34.738835 kernel: e820: reserve RAM buffer [mem 0x3ff1f000-0x3fffffff] May 22 18:56:34.738844 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 22 18:56:34.738854 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 22 18:56:34.738864 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page May 22 18:56:34.738873 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 22 18:56:34.738885 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page May 22 18:56:34.738898 kernel: ACPI: Added _OSI(Module Device) May 22 18:56:34.738911 kernel: ACPI: Added _OSI(Processor Device) May 22 18:56:34.742066 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 22 18:56:34.742088 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 22 18:56:34.742099 kernel: ACPI: Interpreter enabled May 22 18:56:34.742108 kernel: ACPI: PM: (supports S0 S5) May 22 18:56:34.742121 kernel: ACPI: Using IOAPIC for interrupt routing May 22 18:56:34.742132 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug May 22 18:56:34.742142 kernel: PCI: Ignoring E820 reservations for host bridge windows May 22 18:56:34.742152 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F May 22 18:56:34.742162 kernel: iommu: Default domain type: Translated May 22 18:56:34.742172 kernel: iommu: DMA domain TLB invalidation policy: lazy mode May 22 18:56:34.742181 kernel: efivars: Registered efivars operations May 22 18:56:34.742193 kernel: PCI: Using ACPI for IRQ routing May 22 18:56:34.742202 kernel: PCI: System does not support PCI May 22 18:56:34.742213 kernel: vgaarb: loaded May 22 18:56:34.742223 kernel: clocksource: Switched to clocksource tsc-early May 22 18:56:34.742233 kernel: VFS: Disk quotas dquot_6.6.0 May 22 18:56:34.742243 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 22 18:56:34.742253 kernel: pnp: PnP ACPI init May 22 18:56:34.742265 kernel: pnp: PnP ACPI: found 3 devices May 22 18:56:34.742275 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns May 22 18:56:34.742285 kernel: NET: Registered PF_INET protocol family May 22 18:56:34.742295 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) May 22 18:56:34.742305 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) May 22 18:56:34.742315 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 22 18:56:34.742324 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) May 22 18:56:34.742335 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) May 22 18:56:34.742345 kernel: TCP: Hash tables configured (established 65536 bind 65536) May 22 18:56:34.742355 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) May 22 18:56:34.742365 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) May 22 18:56:34.742375 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 22 18:56:34.742384 kernel: NET: Registered PF_XDP protocol family May 22 18:56:34.742394 kernel: PCI: CLS 0 bytes, default 64 May 22 18:56:34.742406 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) May 22 18:56:34.742416 kernel: software IO TLB: mapped [mem 0x000000003a9aa000-0x000000003e9aa000] (64MB) May 22 18:56:34.742426 kernel: RAPL PMU: API unit is 2^-32 Joules, 1 fixed counters, 10737418240 ms ovfl timer May 22 18:56:34.742437 kernel: RAPL PMU: hw unit of domain psys 2^-0 Joules May 22 18:56:34.742447 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212733415c7, max_idle_ns: 440795236380 ns May 22 18:56:34.742457 kernel: clocksource: Switched to clocksource tsc May 22 18:56:34.742466 kernel: Initialise system trusted keyrings May 22 18:56:34.742478 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 May 22 18:56:34.742488 kernel: Key type asymmetric registered May 22 18:56:34.742498 kernel: Asymmetric key parser 'x509' registered May 22 18:56:34.742508 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 22 18:56:34.742518 kernel: io scheduler mq-deadline registered May 22 18:56:34.742528 kernel: io scheduler kyber registered May 22 18:56:34.742538 kernel: io scheduler bfq registered May 22 18:56:34.742549 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 May 22 18:56:34.742558 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 22 18:56:34.742568 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A May 22 18:56:34.742578 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A May 22 18:56:34.742588 kernel: serial8250: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A May 22 18:56:34.742597 kernel: ACPI: bus type drm_connector registered May 22 18:56:34.742606 kernel: i8042: PNP: No PS/2 controller found. May 22 18:56:34.742823 kernel: rtc_cmos 00:02: registered as rtc0 May 22 18:56:34.743016 kernel: rtc_cmos 00:02: setting system clock to 2026-05-22T18:56:30 UTC (1779476190) May 22 18:56:34.743152 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram May 22 18:56:34.743165 kernel: intel_pstate: Intel P-state driver initializing May 22 18:56:34.743175 kernel: efifb: probing for efifb May 22 18:56:34.743186 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k May 22 18:56:34.743205 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 May 22 18:56:34.743216 kernel: efifb: scrolling: redraw May 22 18:56:34.743226 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 May 22 18:56:34.743237 kernel: Console: switching to colour frame buffer device 128x48 May 22 18:56:34.743250 kernel: fb0: EFI VGA frame buffer device May 22 18:56:34.743260 kernel: pstore: Using crash dump compression: deflate May 22 18:56:34.743270 kernel: pstore: Registered efi_pstore as persistent store backend May 22 18:56:34.743280 kernel: NET: Registered PF_INET6 protocol family May 22 18:56:34.743292 kernel: Segment Routing with IPv6 May 22 18:56:34.743303 kernel: In-situ OAM (IOAM) with IPv6 May 22 18:56:34.743313 kernel: NET: Registered PF_PACKET protocol family May 22 18:56:34.743323 kernel: Key type dns_resolver registered May 22 18:56:34.743333 kernel: IPI shorthand broadcast: enabled May 22 18:56:34.743343 kernel: sched_clock: Marking stable (2030004227, 95302362)->(2467038172, -341731583) May 22 18:56:34.743353 kernel: registered taskstats version 1 May 22 18:56:34.743365 kernel: Loading compiled-in X.509 certificates May 22 18:56:34.743375 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.90-flatcar: 84c66e33e90bd2c3a833720e1054371cb72bb7d1' May 22 18:56:34.743385 kernel: Demotion targets for Node 0: null May 22 18:56:34.743395 kernel: Key type .fscrypt registered May 22 18:56:34.743405 kernel: Key type fscrypt-provisioning registered May 22 18:56:34.743415 kernel: ima: No TPM chip found, activating TPM-bypass! May 22 18:56:34.743425 kernel: ima: Allocated hash algorithm: sha1 May 22 18:56:34.743437 kernel: ima: No architecture policies found May 22 18:56:34.743447 kernel: clk: Disabling unused clocks May 22 18:56:34.743458 kernel: Freeing unused kernel image (initmem) memory: 15988K May 22 18:56:34.743467 kernel: Write protecting the kernel read-only data: 47104k May 22 18:56:34.743478 kernel: Freeing unused kernel image (rodata/data gap) memory: 608K May 22 18:56:34.743487 kernel: Run /init as init process May 22 18:56:34.743496 kernel: with arguments: May 22 18:56:34.743508 kernel: /init May 22 18:56:34.743517 kernel: with environment: May 22 18:56:34.743526 kernel: HOME=/ May 22 18:56:34.743535 kernel: TERM=linux May 22 18:56:34.743544 kernel: hv_vmbus: Vmbus version:5.3 May 22 18:56:34.743553 kernel: pps_core: LinuxPPS API ver. 1 registered May 22 18:56:34.743562 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti May 22 18:56:34.743571 kernel: PTP clock support registered May 22 18:56:34.743582 kernel: hv_utils: Registering HyperV Utility Driver May 22 18:56:34.743591 kernel: hv_vmbus: registering driver hv_utils May 22 18:56:34.743600 kernel: hv_utils: Shutdown IC version 3.2 May 22 18:56:34.743609 kernel: hv_utils: Heartbeat IC version 3.0 May 22 18:56:34.743619 kernel: hv_utils: TimeSync IC version 4.0 May 22 18:56:34.743627 kernel: hv_vmbus: registering driver hv_pci May 22 18:56:34.743637 kernel: SCSI subsystem initialized May 22 18:56:34.743826 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI VMBus probing: Using version 0x10004 May 22 18:56:34.744493 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI host bridge to bus c05b:00 May 22 18:56:34.744676 kernel: pci_bus c05b:00: root bus resource [mem 0xfc0000000-0xfc007ffff window] May 22 18:56:34.744832 kernel: pci_bus c05b:00: No busn resource found for root bus, will use [bus 00-ff] May 22 18:56:34.745031 kernel: pci c05b:00:00.0: [1414:00a9] type 00 class 0x010802 PCIe Endpoint May 22 18:56:34.745204 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit] May 22 18:56:34.745357 kernel: pci_bus c05b:00: busn_res: [bus 00-ff] end is updated to 00 May 22 18:56:34.745521 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit]: assigned May 22 18:56:34.745533 kernel: hv_vmbus: registering driver hv_storvsc May 22 18:56:34.745696 kernel: scsi host0: storvsc_host_t May 22 18:56:34.745870 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 May 22 18:56:34.745883 kernel: hid: raw HID events driver (C) Jiri Kosina May 22 18:56:34.745893 kernel: hv_vmbus: registering driver hid_hyperv May 22 18:56:34.745903 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 May 22 18:56:34.746222 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on May 22 18:56:34.746236 kernel: hv_vmbus: registering driver hyperv_keyboard May 22 18:56:34.746249 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:56:34.747225 kernel: nvme nvme0: pci function c05b:00:00.0 May 22 18:56:34.748009 kernel: nvme c05b:00:00.0: enabling device (0000 -> 0002) May 22 18:56:34.748463 kernel: nvme nvme0: 2/0/0 default/read/poll queues May 22 18:56:34.748484 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 22 18:56:34.748691 kernel: sr 0:0:0:2: [sr0] scsi-1 drive May 22 18:56:34.748714 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 May 22 18:56:34.748901 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 May 22 18:56:34.748929 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 22 18:56:34.748942 kernel: device-mapper: uevent: version 1.0.3 May 22 18:56:34.748970 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev May 22 18:56:34.748984 kernel: device-mapper: verity: sha256 using shash "sha256-generic" May 22 18:56:34.748998 kernel: raid6: avx512x4 gen() 42350 MB/s May 22 18:56:34.749007 kernel: raid6: avx512x2 gen() 41859 MB/s May 22 18:56:34.749017 kernel: raid6: avx512x1 gen() 25261 MB/s May 22 18:56:34.749026 kernel: raid6: avx2x4 gen() 34233 MB/s May 22 18:56:34.749036 kernel: raid6: avx2x2 gen() 36417 MB/s May 22 18:56:34.749045 kernel: raid6: avx2x1 gen() 29699 MB/s May 22 18:56:34.749056 kernel: raid6: using algorithm avx512x4 gen() 42350 MB/s May 22 18:56:34.749066 kernel: raid6: .... xor() 7532 MB/s, rmw enabled May 22 18:56:34.749081 kernel: raid6: using avx512x2 recovery algorithm May 22 18:56:34.749091 kernel: xor: automatically using best checksumming function avx May 22 18:56:34.749101 kernel: Btrfs loaded, zoned=no, fsverity=no May 22 18:56:34.749114 kernel: BTRFS: device fsid 994ff57d-783d-4a21-97d1-907bbd4728b4 devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (881) May 22 18:56:34.749124 kernel: BTRFS info (device dm-0): first mount of filesystem 994ff57d-783d-4a21-97d1-907bbd4728b4 May 22 18:56:34.749134 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm May 22 18:56:34.749144 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations May 22 18:56:34.749158 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time May 22 18:56:34.749169 kernel: BTRFS info (device dm-0 state E): enabling free space tree May 22 18:56:34.749179 kernel: loop: module loaded May 22 18:56:34.749189 kernel: loop0: detected capacity change from 0 to 107200 May 22 18:56:34.749199 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 22 18:56:34.749211 systemd[1]: /etc/systemd/system.conf.d/nocgroup.conf:2: Support for option DefaultCPUAccounting= has been removed and it is ignored May 22 18:56:34.749230 systemd[1]: /etc/systemd/system.conf.d/nocgroup.conf:5: Support for option DefaultBlockIOAccounting= has been removed and it is ignored May 22 18:56:34.749241 systemd[1]: Successfully made /usr/ read-only. May 22 18:56:34.749253 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:56:34.749263 systemd[1]: Detected virtualization microsoft. May 22 18:56:34.749275 systemd[1]: Detected architecture x86-64. May 22 18:56:34.749286 systemd[1]: Running in initrd. May 22 18:56:34.749302 systemd[1]: Initializing machine ID from random generator. May 22 18:56:34.749312 systemd[1]: No hostname configured, using default hostname. May 22 18:56:34.749322 systemd[1]: Hostname set to . May 22 18:56:34.749333 systemd[1]: Queued start job for default target initrd.target. May 22 18:56:34.749347 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. May 22 18:56:34.749359 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 22 18:56:34.749369 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 22 18:56:34.749380 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 22 18:56:34.749390 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 22 18:56:34.749400 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 22 18:56:34.749412 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 22 18:56:34.749422 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 22 18:56:34.749433 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 22 18:56:34.749445 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. May 22 18:56:34.749456 systemd[1]: Reached target paths.target - Path Units. May 22 18:56:34.749465 systemd[1]: Reached target slices.target - Slice Units. May 22 18:56:34.749477 systemd[1]: Reached target swap.target - Swaps. May 22 18:56:34.749488 systemd[1]: Reached target timers.target - Timer Units. May 22 18:56:34.749498 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 22 18:56:34.749510 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 22 18:56:34.749520 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. May 22 18:56:34.749531 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 22 18:56:34.749541 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 22 18:56:34.749554 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 22 18:56:34.749564 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 22 18:56:34.749575 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 22 18:56:34.749586 systemd[1]: Reached target sockets.target - Socket Units. May 22 18:56:34.749597 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 22 18:56:34.749607 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 22 18:56:34.749618 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 22 18:56:34.749630 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 22 18:56:34.749642 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:56:34.749968 systemd[1]: Starting systemd-fsck-usr.service... May 22 18:56:34.749981 systemd[1]: Starting systemd-journald.service - Journal Service... May 22 18:56:34.749995 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 22 18:56:34.750006 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:56:34.750045 systemd-journald[1016]: Collecting audit messages is enabled. May 22 18:56:34.750075 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 22 18:56:34.750086 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 22 18:56:34.750098 kernel: audit: type=1130 audit(1779476194.735:2): 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:56:34.750109 kernel: audit: type=1130 audit(1779476194.745:3): 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:56:34.750119 systemd[1]: Finished systemd-fsck-usr.service. May 22 18:56:34.750131 systemd-journald[1016]: Journal started May 22 18:56:34.750157 systemd-journald[1016]: Runtime Journal (/run/log/journal/482fe19367af4851b05da6934a681d45) is 8M, max 158.5M, 150.5M free. May 22 18:56:34.735000 audit[1]: SERVICE_START 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:56:34.745000 audit[1]: SERVICE_START 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:56:34.751000 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:56:34.753977 systemd[1]: Started systemd-journald.service - Journal Service. May 22 18:56:34.754002 kernel: audit: type=1130 audit(1779476194.751:4): 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:56:34.756000 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:56:34.762951 kernel: audit: type=1130 audit(1779476194.756:5): 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:56:34.763735 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 22 18:56:34.771370 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 22 18:56:34.840941 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:56:34.847732 systemd-modules-load[1018]: Inserted module 'br_netfilter' May 22 18:56:34.848408 kernel: Bridge firewalling registered May 22 18:56:34.849732 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 22 18:56:34.850000 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:56:34.855518 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 22 18:56:34.856002 kernel: audit: type=1130 audit(1779476194.850:6): 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:56:34.863993 systemd-tmpfiles[1027]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. May 22 18:56:34.868152 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 22 18:56:34.867000 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:56:34.872000 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:56:34.876639 kernel: audit: type=1130 audit(1779476194.867:7): 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:56:34.873430 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 22 18:56:34.883219 kernel: audit: type=1130 audit(1779476194.872:8): 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:56:34.879173 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 22 18:56:34.888606 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:56:34.888000 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:56:34.894304 kernel: audit: type=1130 audit(1779476194.888:9): 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:56:34.896004 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 22 18:56:34.906001 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 22 18:56:34.905000 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:56:34.911539 kernel: audit: type=1130 audit(1779476194.905:10): 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:56:34.910000 audit: BPF prog-id=5 op=LOAD May 22 18:56:34.914711 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 22 18:56:34.920268 kernel: audit: type=1334 audit(1779476194.910:11): prog-id=5 op=LOAD May 22 18:56:34.920307 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 22 18:56:34.919000 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:56:34.930967 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 22 18:56:34.936000 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:56:34.939026 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 22 18:56:34.957973 dracut-cmdline[1056]: dracut-109 May 22 18:56:34.961183 dracut-cmdline[1056]: 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:56:35.038766 systemd-resolved[1042]: Positive Trust Anchors: May 22 18:56:35.038779 systemd-resolved[1042]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 22 18:56:35.038783 systemd-resolved[1042]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 May 22 18:56:35.038825 systemd-resolved[1042]: 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:56:35.275455 systemd-resolved[1042]: Defaulting to hostname 'linux'. May 22 18:56:35.278368 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 22 18:56:35.279000 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:56:35.280528 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 22 18:56:35.320963 kernel: Loading iSCSI transport class v2.0-870. May 22 18:56:35.392941 kernel: iscsi: registered transport (tcp) May 22 18:56:35.445073 kernel: iscsi: registered transport (qla4xxx) May 22 18:56:35.445151 kernel: QLogic iSCSI HBA Driver May 22 18:56:35.496763 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... May 22 18:56:35.515077 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. May 22 18:56:35.514000 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:56:35.516780 systemd[1]: Reached target network-pre.target - Preparation for Network. May 22 18:56:35.555531 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 22 18:56:35.554000 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:56:35.559057 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 22 18:56:35.564045 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 22 18:56:35.590654 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 22 18:56:35.594000 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:56:35.595000 audit: BPF prog-id=6 op=LOAD May 22 18:56:35.596000 audit: BPF prog-id=7 op=LOAD May 22 18:56:35.598054 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 22 18:56:35.648466 systemd-udevd[1295]: Using default interface naming scheme 'v258'. May 22 18:56:35.652297 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 22 18:56:35.651000 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:56:35.743130 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 22 18:56:35.748000 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:56:35.751537 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 22 18:56:35.756000 audit: BPF prog-id=8 op=LOAD May 22 18:56:35.760048 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 22 18:56:35.783775 dracut-pre-trigger[1395]: rd.md=0: removing MD RAID activation May 22 18:56:35.808569 systemd-networkd[1398]: lo: Link UP May 22 18:56:35.808575 systemd-networkd[1398]: lo: Gained carrier May 22 18:56:35.813000 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:56:35.814000 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:56:35.810995 systemd[1]: Started systemd-networkd.service - Network Configuration. May 22 18:56:35.814995 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 22 18:56:35.816677 systemd[1]: Reached target network.target - Network. May 22 18:56:35.818036 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 22 18:56:35.885085 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 22 18:56:35.887000 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:56:35.890344 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 22 18:56:35.995949 kernel: hv_vmbus: registering driver hv_netvsc May 22 18:56:36.008946 kernel: hv_netvsc f8615163-0000-1000-2000-70a8a54e6723 (unnamed net_device) (uninitialized): VF slot 1 added May 22 18:56:36.020988 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#225 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 May 22 18:56:36.027322 systemd-networkd[1398]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network May 22 18:56:36.027329 systemd-networkd[1398]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 22 18:56:36.030771 systemd-networkd[1398]: eth0: Link UP May 22 18:56:36.030876 systemd-networkd[1398]: eth0: Gained carrier May 22 18:56:36.030890 systemd-networkd[1398]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network May 22 18:56:36.040275 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 22 18:56:36.044000 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:56:36.040464 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:56:36.045640 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:56:36.057490 kernel: cryptd: max_cpu_qlen set to 1000 May 22 18:56:36.051999 systemd-networkd[1398]: eth0: DHCPv4 address 10.0.0.11/24, gateway 10.0.0.1 acquired from 168.63.129.16 May 22 18:56:36.055179 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:56:36.089489 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:56:36.092000 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:56:36.096222 kernel: AES CTR mode by8 optimization enabled May 22 18:56:36.220984 kernel: nvme nvme0: using unchecked data buffer May 22 18:56:36.314695 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - MSFT NVMe Accelerator v1.0 USR-A. May 22 18:56:36.319225 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 22 18:56:36.426713 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. May 22 18:56:36.459337 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - MSFT NVMe Accelerator v1.0 ROOT. May 22 18:56:36.469238 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - MSFT NVMe Accelerator v1.0 EFI-SYSTEM. May 22 18:56:36.489757 systemd[1]: Mounting oem.mount - /oem... May 22 18:56:36.571415 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1588) May 22 18:56:36.571464 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem e33db1dc-bf4d-468d-946e-8f4b5a090363 May 22 18:56:36.572179 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm May 22 18:56:36.580773 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 22 18:56:36.582000 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:56:36.584350 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 22 18:56:36.584749 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 22 18:56:36.585281 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 22 18:56:36.590437 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 22 18:56:36.621544 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 22 18:56:36.626000 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:56:36.673942 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations May 22 18:56:36.673998 kernel: BTRFS info (device nvme0n1p6): turning on async discard May 22 18:56:36.674011 kernel: BTRFS info (device nvme0n1p6): enabling free space tree May 22 18:56:36.676485 systemd[1]: Mounted oem.mount - /oem. May 22 18:56:36.679429 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 22 18:56:37.026952 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 May 22 18:56:37.031056 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 May 22 18:56:37.031302 kernel: pci_bus 7870:00: root bus resource [mem 0xfc2000000-0xfc4007fff window] May 22 18:56:37.032686 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] May 22 18:56:37.039026 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint May 22 18:56:37.043154 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref] May 22 18:56:37.047989 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref] May 22 18:56:37.048065 kernel: pci 7870:00:00.0: enabling Extended Tags May 22 18:56:37.064428 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 May 22 18:56:37.064684 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref]: assigned May 22 18:56:37.068080 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref]: assigned May 22 18:56:37.086274 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) May 22 18:56:37.095935 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 May 22 18:56:37.099891 kernel: hv_netvsc f8615163-0000-1000-2000-70a8a54e6723 eth0: VF registering: eth1 May 22 18:56:37.100103 kernel: mana 7870:00:00.0 eth1: joined to eth0 May 22 18:56:37.106500 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 May 22 18:56:37.107342 systemd-networkd[1398]: eth1: Interface name change detected, renamed to enP30832s1. May 22 18:56:37.208097 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 May 22 18:56:37.213973 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 May 22 18:56:37.214266 kernel: hv_netvsc f8615163-0000-1000-2000-70a8a54e6723 eth0: Data path switched to VF: enP30832s1 May 22 18:56:37.214057 systemd-networkd[1398]: enP30832s1: Link UP May 22 18:56:37.214411 systemd-networkd[1398]: enP30832s1: Gained carrier May 22 18:56:37.469059 systemd-networkd[1398]: eth0: Gained IPv6LL May 22 18:56:37.679383 disk-uuid[1580]: Warning: The kernel is still using the old partition table. May 22 18:56:37.679383 disk-uuid[1580]: The new table will be used at the next reboot or after you May 22 18:56:37.679383 disk-uuid[1580]: run partprobe(8) or kpartx(8) May 22 18:56:37.679383 disk-uuid[1580]: The operation has completed successfully. May 22 18:56:37.692754 systemd[1]: disk-uuid.service: Deactivated successfully. May 22 18:56:37.696000 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:56:37.696000 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:56:37.692855 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 22 18:56:37.740947 ignition[1629]: Ignition 2.24.0 May 22 18:56:37.740960 ignition[1629]: Stage: fetch-offline May 22 18:56:37.741626 ignition[1629]: no config dir at "/usr/lib/ignition/base.d" May 22 18:56:37.747000 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:56:37.743569 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 22 18:56:37.741642 ignition[1629]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:56:37.752563 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... May 22 18:56:37.741746 ignition[1629]: parsed url from cmdline: "" May 22 18:56:37.741750 ignition[1629]: no config URL provided May 22 18:56:37.741837 ignition[1629]: reading system config file "/usr/lib/ignition/user.ign" May 22 18:56:37.741859 ignition[1629]: no config at "/usr/lib/ignition/user.ign" May 22 18:56:37.741868 ignition[1629]: failed to fetch config: resource requires networking May 22 18:56:37.742332 ignition[1629]: Ignition finished successfully May 22 18:56:37.772803 ignition[1648]: Ignition 2.24.0 May 22 18:56:37.772814 ignition[1648]: Stage: fetch May 22 18:56:37.773080 ignition[1648]: no config dir at "/usr/lib/ignition/base.d" May 22 18:56:37.773088 ignition[1648]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:56:37.773183 ignition[1648]: parsed url from cmdline: "" May 22 18:56:37.773186 ignition[1648]: no config URL provided May 22 18:56:37.773192 ignition[1648]: reading system config file "/usr/lib/ignition/user.ign" May 22 18:56:37.773201 ignition[1648]: no config at "/usr/lib/ignition/user.ign" May 22 18:56:37.773220 ignition[1648]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 May 22 18:56:37.882301 ignition[1648]: GET result: OK May 22 18:56:37.882370 ignition[1648]: config has been read from IMDS userdata May 22 18:56:37.882383 ignition[1648]: parsing config with SHA512: 09eb8a3a0787b9e7f8315947ee39ed24c6a000b1a14219a8b0cfa4216eefde8b565094b629d98c9dc8752ac77df705d258353b22d25af07eccf5c7fc707ba9e1 May 22 18:56:37.888596 unknown[1648]: fetched base config from "system" May 22 18:56:37.888609 unknown[1648]: fetched base config from "system" May 22 18:56:37.891000 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:56:37.888812 ignition[1648]: fetch: fetch complete May 22 18:56:37.888614 unknown[1648]: fetched user config from "azure" May 22 18:56:37.888817 ignition[1648]: fetch: fetch passed May 22 18:56:37.891451 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). May 22 18:56:37.888860 ignition[1648]: Ignition finished successfully May 22 18:56:37.893074 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 22 18:56:37.918256 ignition[1654]: Ignition 2.24.0 May 22 18:56:37.918267 ignition[1654]: Stage: kargs May 22 18:56:37.918502 ignition[1654]: no config dir at "/usr/lib/ignition/base.d" May 22 18:56:37.918509 ignition[1654]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:56:37.919210 ignition[1654]: kargs: kargs passed May 22 18:56:37.923847 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 22 18:56:37.919246 ignition[1654]: Ignition finished successfully May 22 18:56:37.928000 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:56:37.930843 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 22 18:56:37.985786 systemd[1]: ignition-kargs.service: Deactivated successfully. May 22 18:56:37.985890 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 22 18:56:37.987000 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:56:37.988752 systemd[1]: ignition-fetch.service: Deactivated successfully. May 22 18:56:37.992000 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:56:37.993000 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:56:37.988877 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). May 22 18:56:37.993221 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 22 18:56:37.993346 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 22 18:56:37.996155 systemd[1]: Unmounting oem.mount - /oem... May 22 18:56:38.013960 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem e33db1dc-bf4d-468d-946e-8f4b5a090363 May 22 18:56:38.014487 systemd[1]: oem.mount: Deactivated successfully. May 22 18:56:38.014620 systemd[1]: Unmounted oem.mount - /oem. May 22 18:56:38.040286 ignition[1664]: Ignition 2.24.0 May 22 18:56:38.040298 ignition[1664]: Stage: disks May 22 18:56:38.042000 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:56:38.040514 ignition[1664]: no config dir at "/usr/lib/ignition/base.d" May 22 18:56:38.042552 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 22 18:56:38.040521 ignition[1664]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:56:38.043140 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 22 18:56:38.041121 ignition[1664]: disks: disks passed May 22 18:56:38.043489 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 22 18:56:38.041158 ignition[1664]: Ignition finished successfully May 22 18:56:38.043516 systemd[1]: Reached target local-fs.target - Local File Systems. May 22 18:56:38.043537 systemd[1]: Reached target sysinit.target - System Initialization. May 22 18:56:38.043765 systemd[1]: Reached target basic.target - Basic System. May 22 18:56:38.046071 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 22 18:56:38.125228 systemd-fsck[1674]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks May 22 18:56:38.130113 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 22 18:56:38.133000 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:56:38.136399 systemd[1]: Mounting sysroot.mount - /sysroot... May 22 18:56:38.434941 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 47741ff1-2f1b-4b93-b3f5-dcc2ee688f01 r/w with ordered data mode. Quota mode: none. May 22 18:56:38.435849 systemd[1]: Mounted sysroot.mount - /sysroot. May 22 18:56:38.437776 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 22 18:56:38.451789 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 22 18:56:38.456353 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... May 22 18:56:38.461141 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:56:38.461184 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 22 18:56:38.466653 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 22 18:56:38.481535 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 22 18:56:39.034085 coreos-metadata[1684]: May 22 18:56:39.033 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 May 22 18:56:39.038154 coreos-metadata[1684]: May 22 18:56:39.038 INFO Fetch successful May 22 18:56:39.038154 coreos-metadata[1684]: May 22 18:56:39.038 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 May 22 18:56:39.048686 coreos-metadata[1684]: May 22 18:56:39.048 INFO Fetch successful May 22 18:56:39.052005 coreos-metadata[1684]: May 22 18:56:39.050 INFO wrote hostname ci-4694.0.1-a-4719f96d26 to /sysroot/etc/hostname May 22 18:56:39.051424 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. May 22 18:56:39.058000 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:56:40.024943 kernel: loop1: detected capacity change from 0 to 43464 May 22 18:56:40.055939 kernel: loop1: p1 p2 p3 May 22 18:56:40.461401 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:40.461480 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:40.463087 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:40.464372 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:40.464886 systemd-confext[1767]: device-mapper: reload ioctl on 34c0bb0cf7c56978b902b451b6b90d2903015da37e581b8f5a52ffa1a203cba5-verity (254:1) failed: Invalid argument May 22 18:56:40.487942 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:40.566957 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. May 22 18:56:40.588942 kernel: loop2: detected capacity change from 0 to 43464 May 22 18:56:40.590940 kernel: loop2: p1 p2 p3 May 22 18:56:40.601673 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:40.601724 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:40.604083 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:40.606742 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:40.606511 (sd-merge)[1777]: device-mapper: reload ioctl on 34c0bb0cf7c56978b902b451b6b90d2903015da37e581b8f5a52ffa1a203cba5-verity (254:1) failed: Invalid argument May 22 18:56:40.615039 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:40.635861 (sd-merge)[1777]: Using extensions '00-flatcar-default.raw'. May 22 18:56:40.636779 (sd-merge)[1777]: Merged extensions into '/sysroot/etc'. May 22 18:56:40.641425 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. May 22 18:56:40.643410 initrd-setup-root[1785]: /etc 00-flatcar-default Fri 2026-05-22 18:56:34 UTC May 22 18:56:40.644486 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 22 18:56:40.646000 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:56:40.652803 kernel: kauditd_printk_skb: 29 callbacks suppressed May 22 18:56:40.652822 kernel: audit: type=1130 audit(1779476200.646:41): 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:56:40.653257 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 22 18:56:40.660111 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 22 18:56:40.691865 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 22 18:56:40.696738 ignition[1790]: INFO : Ignition 2.24.0 May 22 18:56:40.696738 ignition[1790]: INFO : Stage: mount May 22 18:56:40.696000 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:56:40.701000 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:56:40.713015 kernel: audit: type=1130 audit(1779476200.696:42): 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:56:40.699160 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 22 18:56:40.714418 ignition[1790]: INFO : no config dir at "/usr/lib/ignition/base.d" May 22 18:56:40.714418 ignition[1790]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:56:40.714418 ignition[1790]: INFO : mount: mount passed May 22 18:56:40.714418 ignition[1790]: INFO : Ignition finished successfully May 22 18:56:40.719823 kernel: audit: type=1130 audit(1779476200.701:43): 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:56:40.703605 systemd[1]: Starting ignition-files.service - Ignition (files)... May 22 18:56:40.728592 systemd[1]: Mounting oem.mount - /oem... May 22 18:56:40.744941 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1802) May 22 18:56:40.744976 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem e33db1dc-bf4d-468d-946e-8f4b5a090363 May 22 18:56:40.746964 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm May 22 18:56:40.755585 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations May 22 18:56:40.755620 kernel: BTRFS info (device nvme0n1p6): turning on async discard May 22 18:56:40.755632 kernel: BTRFS info (device nvme0n1p6): enabling free space tree May 22 18:56:40.758595 systemd[1]: Mounted oem.mount - /oem. May 22 18:56:40.761327 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 22 18:56:40.773867 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 22 18:56:40.800313 ignition[1820]: INFO : Ignition 2.24.0 May 22 18:56:40.800313 ignition[1820]: INFO : Stage: files May 22 18:56:40.806974 ignition[1820]: INFO : no config dir at "/usr/lib/ignition/base.d" May 22 18:56:40.806974 ignition[1820]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:56:40.806974 ignition[1820]: DEBUG : files: compiled without relabeling support, skipping May 22 18:56:40.816656 ignition[1820]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 22 18:56:40.816656 ignition[1820]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 22 18:56:40.822267 ignition[1820]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 22 18:56:40.822267 ignition[1820]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 22 18:56:40.822267 ignition[1820]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 22 18:56:40.822267 ignition[1820]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 22 18:56:40.822267 ignition[1820]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 22 18:56:40.822267 ignition[1820]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/var/lib/iptables/rules-save" May 22 18:56:40.822267 ignition[1820]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/var/lib/iptables/rules-save" May 22 18:56:40.822267 ignition[1820]: INFO : files: op(5): [started] processing unit "iptables-restore.service" May 22 18:56:40.822267 ignition[1820]: INFO : files: op(5): [finished] processing unit "iptables-restore.service" May 22 18:56:40.822267 ignition[1820]: INFO : files: op(6): [started] setting preset to enabled for "iptables-restore.service" May 22 18:56:40.822267 ignition[1820]: INFO : files: op(6): [finished] setting preset to enabled for "iptables-restore.service" May 22 18:56:40.822267 ignition[1820]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" May 22 18:56:40.822267 ignition[1820]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" May 22 18:56:40.822267 ignition[1820]: INFO : files: files passed May 22 18:56:40.822267 ignition[1820]: INFO : Ignition finished successfully May 22 18:56:40.823000 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:56:40.820024 unknown[1820]: wrote ssh authorized keys file for user: core May 22 18:56:40.858859 kernel: audit: type=1130 audit(1779476200.823:44): 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:56:40.822954 systemd[1]: Finished ignition-files.service - Ignition (files). May 22 18:56:40.873000 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:56:40.831048 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 22 18:56:40.873000 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:56:40.882149 kernel: audit: type=1130 audit(1779476200.873:45): 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:56:40.839015 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 22 18:56:40.888747 kernel: audit: type=1131 audit(1779476200.873:46): 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:56:40.852013 systemd[1]: ignition-quench.service: Deactivated successfully. May 22 18:56:40.852127 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 22 18:56:40.912358 initrd-setup-root-after-ignition[1854]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 22 18:56:40.915241 initrd-setup-root-after-ignition[1854]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 22 18:56:40.918480 initrd-setup-root-after-ignition[1858]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 22 18:56:40.922438 kernel: loop3: detected capacity change from 0 to 43464 May 22 18:56:40.924936 kernel: loop3: p1 p2 p3 May 22 18:56:40.939416 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:40.939450 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:40.941996 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:40.943701 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:40.943766 systemd-confext[1860]: device-mapper: reload ioctl on loop3p1-verity (254:2) failed: Invalid argument May 22 18:56:40.953977 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:40.969987 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. May 22 18:56:40.989142 kernel: loop4: detected capacity change from 0 to 43464 May 22 18:56:40.989302 kernel: loop4: p1 p2 p3 May 22 18:56:40.996534 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:40.996581 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:40.997656 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:40.999025 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:40.999049 (sd-merge)[1868]: device-mapper: reload ioctl on loop4p1-verity (254:2) failed: Invalid argument May 22 18:56:41.002935 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:41.017369 (sd-merge)[1868]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. May 22 18:56:41.021989 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. May 22 18:56:41.097943 kernel: loop4: detected capacity change from 0 to 178200 May 22 18:56:41.154946 kernel: loop4: p1 p2 p3 May 22 18:56:41.520663 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:41.520732 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:41.523001 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:41.523150 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:41.523757 systemd-sysext[1876]: device-mapper: reload ioctl on 76e564ce832c92102e0654503bbfd4392ed6cbfef96de72cad1d345713379e94-verity (254:2) failed: Invalid argument May 22 18:56:41.534953 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:41.622945 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. May 22 18:56:41.657949 kernel: loop5: detected capacity change from 0 to 378016 May 22 18:56:41.817148 kernel: loop5: p1 p2 p3 May 22 18:56:42.577773 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:42.577842 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:42.580587 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:42.582575 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:42.582650 systemd-sysext[1876]: device-mapper: reload ioctl on 95e1797b1c18833e5778f5d77b5f1ee1782531a60657be5a26ef59522d21e1dc-verity (254:2) failed: Invalid argument May 22 18:56:42.587755 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:42.958942 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. May 22 18:56:43.221108 kernel: loop6: detected capacity change from 0 to 136912 May 22 18:56:43.236252 kernel: loop6: p1 p2 p3 May 22 18:56:43.916580 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:43.916650 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:43.919367 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:43.920282 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:43.920756 systemd-sysext[1876]: device-mapper: reload ioctl on 13729d316cd67e1d034d8331f36a5bad38437e7a747108afcb7e4d2c7a932a72-verity (254:2) failed: Invalid argument May 22 18:56:43.927661 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:44.010943 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. May 22 18:56:44.032939 kernel: loop7: detected capacity change from 0 to 178200 May 22 18:56:44.034939 kernel: loop7: p1 p2 p3 May 22 18:56:44.053653 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:44.053703 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:44.053722 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:44.055313 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:44.055354 (sd-merge)[1899]: device-mapper: reload ioctl on 76e564ce832c92102e0654503bbfd4392ed6cbfef96de72cad1d345713379e94-verity (254:2) failed: Invalid argument May 22 18:56:44.062038 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:44.264991 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. May 22 18:56:44.268422 kernel: loop1: detected capacity change from 0 to 378016 May 22 18:56:44.268476 kernel: loop1: p1 p2 p3 May 22 18:56:44.296210 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:44.296263 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:44.300415 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:44.300454 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:44.300509 (sd-merge)[1899]: device-mapper: reload ioctl on 95e1797b1c18833e5778f5d77b5f1ee1782531a60657be5a26ef59522d21e1dc-verity (254:3) failed: Invalid argument May 22 18:56:44.306270 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:44.359939 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. May 22 18:56:44.363695 kernel: loop3: detected capacity change from 0 to 136912 May 22 18:56:44.363734 kernel: loop3: p1 p2 p3 May 22 18:56:44.377896 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:44.377967 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:44.383467 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:44.383514 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:44.383949 (sd-merge)[1899]: device-mapper: reload ioctl on 13729d316cd67e1d034d8331f36a5bad38437e7a747108afcb7e4d2c7a932a72-verity (254:4) failed: Invalid argument May 22 18:56:44.391946 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:44.418709 (sd-merge)[1899]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4694.0.1.raw'. May 22 18:56:44.419832 (sd-merge)[1899]: Merged extensions into '/sysroot/usr'. May 22 18:56:44.423307 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. May 22 18:56:44.424356 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 22 18:56:44.425000 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:56:44.431221 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 22 18:56:44.439998 kernel: audit: type=1130 audit(1779476204.425:47): 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:56:44.453375 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 22 18:56:44.453487 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 22 18:56:44.455000 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:56:44.456593 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. May 22 18:56:44.455000 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:56:44.471509 kernel: audit: type=1130 audit(1779476204.455:48): 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:56:44.457045 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 22 18:56:44.474008 kernel: audit: type=1131 audit(1779476204.455:49): 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:56:44.458356 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 22 18:56:44.459166 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 22 18:56:44.484207 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 22 18:56:44.485000 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:56:44.490954 kernel: audit: type=1130 audit(1779476204.485:50): 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:56:44.491099 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 22 18:56:44.511796 systemd[1]: Stopped target basic.target - Basic System. May 22 18:56:44.512034 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 22 18:56:44.512178 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 22 18:56:44.512493 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. May 22 18:56:44.512775 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 22 18:56:44.521415 systemd[1]: Stopped target paths.target - Path Units. May 22 18:56:44.523935 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 22 18:56:44.528081 systemd[1]: Stopped target slices.target - Slice Units. May 22 18:56:44.532065 systemd[1]: Stopped target sockets.target - Socket Units. May 22 18:56:44.535366 systemd[1]: Stopped target sysinit.target - System Initialization. May 22 18:56:44.535670 systemd[1]: Stopped target local-fs.target - Local File Systems. May 22 18:56:44.536245 systemd[1]: Stopped target swap.target - Swaps. May 22 18:56:44.536800 systemd[1]: Stopped target timers.target - Timer Units. May 22 18:56:44.537236 systemd[1]: iscsid.socket: Deactivated successfully. May 22 18:56:44.558000 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:56:44.537332 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 22 18:56:44.544664 systemd[1]: iscsiuio.socket: Deactivated successfully. May 22 18:56:44.544739 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 22 18:56:44.550451 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. May 22 18:56:44.550551 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. May 22 18:56:44.557872 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 22 18:56:44.557969 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 22 18:56:44.559703 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 22 18:56:44.561045 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 22 18:56:44.561312 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 22 18:56:44.561409 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 22 18:56:44.582000 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:56:44.583164 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 22 18:56:44.586400 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 22 18:56:44.586825 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 22 18:56:44.591174 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 22 18:56:44.597059 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 22 18:56:44.597419 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 22 18:56:44.603000 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:56:44.603134 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 22 18:56:44.609000 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:56:44.603241 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 22 18:56:44.605010 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 22 18:56:44.613000 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:56:44.605139 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 22 18:56:44.610777 systemd[1]: ignition-files.service: Deactivated successfully. May 22 18:56:44.610867 systemd[1]: Stopped ignition-files.service - Ignition (files). May 22 18:56:44.614716 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. May 22 18:56:44.614808 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. May 22 18:56:44.624000 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:56:44.626418 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 22 18:56:44.629703 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 22 18:56:44.637000 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:56:44.637000 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:56:44.638000 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:56:44.631377 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 22 18:56:44.631541 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 22 18:56:44.650000 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:56:44.650000 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:56:44.638477 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 22 18:56:44.638571 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 22 18:56:44.638880 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 22 18:56:44.663117 ignition[1933]: INFO : Ignition 2.24.0 May 22 18:56:44.663117 ignition[1933]: INFO : Stage: umount May 22 18:56:44.663117 ignition[1933]: INFO : no config dir at "/usr/lib/ignition/base.d" May 22 18:56:44.663117 ignition[1933]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" May 22 18:56:44.663117 ignition[1933]: INFO : umount: umount passed May 22 18:56:44.663117 ignition[1933]: INFO : Ignition finished successfully May 22 18:56:44.663000 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:56:44.664000 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:56:44.665000 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:56:44.639002 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 22 18:56:44.687000 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:56:44.646082 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 22 18:56:44.698000 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:56:44.646192 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 22 18:56:44.663329 systemd[1]: ignition-mount.service: Deactivated successfully. May 22 18:56:44.702000 audit: BPF prog-id=5 op=UNLOAD May 22 18:56:44.703000 audit: BPF prog-id=8 op=UNLOAD May 22 18:56:44.663456 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 22 18:56:44.664692 systemd[1]: Stopped target network.target - Network. May 22 18:56:44.665166 systemd[1]: ignition-disks.service: Deactivated successfully. May 22 18:56:44.665202 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 22 18:56:44.665730 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 22 18:56:44.720000 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:56:44.665752 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 22 18:56:44.666153 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 22 18:56:44.666350 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 22 18:56:44.681873 systemd[1]: systemd-networkd.service: Deactivated successfully. May 22 18:56:44.681990 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 22 18:56:44.690394 systemd[1]: systemd-resolved.service: Deactivated successfully. May 22 18:56:44.690488 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 22 18:56:44.703393 systemd[1]: Stopped target network-pre.target - Preparation for Network. May 22 18:56:44.708147 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 22 18:56:44.708196 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 22 18:56:44.713012 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 22 18:56:44.717000 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 22 18:56:44.717045 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 22 18:56:44.740000 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:56:44.722380 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 22 18:56:44.742000 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:56:44.722417 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 22 18:56:44.741020 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 22 18:56:44.741055 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 22 18:56:44.743179 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 22 18:56:45.150235 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 22 18:56:45.405729 systemd[1]: systemd-udevd.service: Deactivated successfully. May 22 18:56:45.405884 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 22 18:56:45.408000 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:56:45.411007 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 22 18:56:45.411057 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 22 18:56:45.415790 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 22 18:56:45.418000 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:56:45.420000 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:56:45.415834 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 22 18:56:45.421000 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:56:45.422000 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:56:45.423000 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:56:45.419044 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 22 18:56:45.432000 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:56:45.419076 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 22 18:56:45.435000 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:56:45.437000 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:56:45.421178 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 22 18:56:45.421204 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 22 18:56:45.423612 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 22 18:56:45.423793 systemd[1]: systemd-network-generator.service: Deactivated successfully. May 22 18:56:45.423824 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. May 22 18:56:45.423892 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 22 18:56:45.450000 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:56:45.450000 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:56:45.423911 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 22 18:56:45.424065 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. May 22 18:56:45.424093 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 22 18:56:45.433183 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 22 18:56:45.433224 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 22 18:56:45.436083 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 22 18:56:45.436121 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:56:45.442832 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 22 18:56:45.442933 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 22 18:56:45.487880 kernel: hv_netvsc f8615163-0000-1000-2000-70a8a54e6723 eth0: Data path switched from VF: enP30832s1 May 22 18:56:45.488153 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 May 22 18:56:45.489353 systemd[1]: network-cleanup.service: Deactivated successfully. May 22 18:56:45.489478 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 22 18:56:45.492000 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:56:45.805271 systemd[1]: sysroot-boot.service: Deactivated successfully. May 22 18:56:45.805400 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 22 18:56:45.808000 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:56:45.810196 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 22 18:56:45.814295 kernel: kauditd_printk_skb: 33 callbacks suppressed May 22 18:56:45.814321 kernel: audit: type=1131 audit(1779476205.808:84): 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:56:45.816751 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 22 18:56:45.816811 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 22 18:56:45.820000 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:56:45.824070 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 22 18:56:45.827039 kernel: audit: type=1131 audit(1779476205.820:85): 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:56:45.845107 systemd[1]: Switching root. May 22 18:56:46.005057 systemd-journald[1016]: Journal stopped May 22 18:56:55.272861 systemd-journald[1016]: Received SIGTERM from PID 1 (systemd). May 22 18:56:55.272949 kernel: audit: type=1335 audit(1779476206.008:86): pid=1016 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=kernel comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" nl-mcgrp=1 op=disconnect res=1 May 22 18:56:55.272975 kernel: SELinux: policy capability network_peer_controls=1 May 22 18:56:55.272993 kernel: SELinux: policy capability open_perms=1 May 22 18:56:55.273011 kernel: SELinux: policy capability extended_socket_class=1 May 22 18:56:55.273028 kernel: SELinux: policy capability always_check_network=0 May 22 18:56:55.273041 kernel: SELinux: policy capability cgroup_seclabel=1 May 22 18:56:55.273059 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 22 18:56:55.273077 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 22 18:56:55.273094 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 22 18:56:55.273110 kernel: SELinux: policy capability userspace_initial_context=0 May 22 18:56:55.273129 kernel: audit: type=1403 audit(1779476207.962:87): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 22 18:56:55.273149 systemd[1]: Successfully loaded SELinux policy in 155.865ms. May 22 18:56:55.273171 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.810ms. May 22 18:56:55.273192 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:56:55.273209 systemd[1]: Detected virtualization microsoft. May 22 18:56:55.273222 systemd[1]: Detected architecture x86-64. May 22 18:56:55.273235 systemd[1]: Detected first boot. May 22 18:56:55.273252 systemd[1]: Initializing machine ID from random generator. May 22 18:56:55.273264 systemd[1]: Hostname set to . May 22 18:56:55.273276 kernel: audit: type=1334 audit(1779476210.068:88): prog-id=9 op=LOAD May 22 18:56:55.273286 kernel: audit: type=1334 audit(1779476210.068:89): prog-id=9 op=UNLOAD May 22 18:56:55.273300 zram_generator::config[1979]: No configuration found. May 22 18:56:55.273318 kernel: Guest personality initialized and is inactive May 22 18:56:55.273329 kernel: VMCI host device registered (name=vmci, major=10, minor=259) May 22 18:56:55.273345 kernel: Initialized host personality May 22 18:56:55.273364 kernel: NET: Registered PF_VSOCK protocol family May 22 18:56:55.273379 systemd-ssh-generator[1975]: Failed to query local AF_VSOCK CID: Cannot assign requested address May 22 18:56:55.273400 (sd-exec-[1960]: /usr/lib/systemd/system-generators/systemd-ssh-generator failed with exit status 1. May 22 18:56:55.273416 systemd[1]: Applying preset policy. May 22 18:56:55.273429 systemd[1]: Created symlink '/etc/systemd/system/basic.target.wants/iptables-restore.service' → '/usr/lib/systemd/system/iptables-restore.service'. May 22 18:56:55.273450 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:56:55.273464 systemd[1]: Populated /etc with preset unit settings. May 22 18:56:55.273480 kernel: audit: type=1334 audit(1779476214.791:90): prog-id=10 op=LOAD May 22 18:56:55.273496 kernel: audit: type=1334 audit(1779476214.791:91): prog-id=2 op=UNLOAD May 22 18:56:55.273509 kernel: audit: type=1334 audit(1779476214.791:92): prog-id=11 op=LOAD May 22 18:56:55.273521 kernel: audit: type=1334 audit(1779476214.791:93): prog-id=12 op=LOAD May 22 18:56:55.273539 kernel: audit: type=1334 audit(1779476214.791:94): prog-id=3 op=UNLOAD May 22 18:56:55.273549 kernel: audit: type=1334 audit(1779476214.791:95): prog-id=4 op=UNLOAD May 22 18:56:55.273562 kernel: audit: type=1334 audit(1779476214.793:96): prog-id=13 op=LOAD May 22 18:56:55.273581 kernel: audit: type=1334 audit(1779476214.793:97): prog-id=10 op=UNLOAD May 22 18:56:55.273591 kernel: audit: type=1334 audit(1779476214.793:98): prog-id=14 op=LOAD May 22 18:56:55.273602 kernel: audit: type=1334 audit(1779476214.793:99): prog-id=15 op=LOAD May 22 18:56:55.273616 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 22 18:56:55.273629 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 22 18:56:55.273640 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 22 18:56:55.273655 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 22 18:56:55.273669 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 22 18:56:55.273683 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 22 18:56:55.273697 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 22 18:56:55.273710 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 22 18:56:55.273726 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 22 18:56:55.273740 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 22 18:56:55.273754 systemd[1]: Created slice user.slice - User and Session Slice. May 22 18:56:55.273769 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 22 18:56:55.273783 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 22 18:56:55.273797 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 22 18:56:55.273813 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 22 18:56:55.273827 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 22 18:56:55.273838 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 22 18:56:55.273850 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... May 22 18:56:55.273863 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... May 22 18:56:55.273876 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 22 18:56:55.273891 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 22 18:56:55.273902 systemd[1]: Reached target imports.target - Image Downloads. May 22 18:56:55.273912 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 22 18:56:55.273951 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 22 18:56:55.273965 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 22 18:56:55.273976 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 22 18:56:55.273991 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 22 18:56:55.274001 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 22 18:56:55.274011 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. May 22 18:56:55.274024 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. May 22 18:56:55.274038 systemd[1]: Reached target slices.target - Slice Units. May 22 18:56:55.274049 systemd[1]: Reached target swap.target - Swaps. May 22 18:56:55.274059 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 22 18:56:55.274070 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. May 22 18:56:55.274083 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 22 18:56:55.274095 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 22 18:56:55.274107 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. May 22 18:56:55.274120 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. May 22 18:56:55.274132 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. May 22 18:56:55.274147 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Service Varlink Socket. May 22 18:56:55.274162 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 22 18:56:55.274174 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. May 22 18:56:55.274187 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. May 22 18:56:55.274199 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. May 22 18:56:55.274210 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. May 22 18:56:55.274220 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 22 18:56:55.274229 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. May 22 18:56:55.274238 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 22 18:56:55.274247 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 22 18:56:55.274256 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 22 18:56:55.274273 systemd[1]: Mounting media.mount - External Media Directory... May 22 18:56:55.274286 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 22 18:56:55.274297 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 22 18:56:55.274307 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 22 18:56:55.274320 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. May 22 18:56:55.274330 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 22 18:56:55.274344 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:56:55.274356 systemd[1]: Reached target machines.target - Virtual Machines and Containers. May 22 18:56:55.274367 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 22 18:56:55.274377 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 22 18:56:55.274390 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 22 18:56:55.274402 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 22 18:56:55.274412 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:56:55.274425 systemd[1]: modprobe@drm.service - Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). May 22 18:56:55.274435 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:56:55.274446 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 22 18:56:55.274456 systemd[1]: modprobe@loop.service - Load Kernel Module loop was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!loop). May 22 18:56:55.274466 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 22 18:56:55.274479 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 22 18:56:55.274491 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 22 18:56:55.274502 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 22 18:56:55.274513 systemd[1]: Stopped systemd-fsck-usr.service. May 22 18:56:55.274524 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:56:55.274536 systemd[1]: Starting systemd-journald.service - Journal Service... May 22 18:56:55.274545 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 22 18:56:55.274563 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... May 22 18:56:55.274575 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 22 18:56:55.274588 systemd[1]: Reached target time-set.target - System Time Set. May 22 18:56:55.274599 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 22 18:56:55.274610 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 22 18:56:55.274621 kernel: fuse: init (API version 7.41) May 22 18:56:55.274632 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 22 18:56:55.274674 systemd-journald[2061]: Collecting audit messages is enabled. May 22 18:56:55.274707 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:56:55.274720 systemd-journald[2061]: Journal started May 22 18:56:55.274745 systemd-journald[2061]: Runtime Journal (/run/log/journal/a9cdf41023da4fb9876f71bfedee1884) is 8M, max 158.5M, 150.5M free. May 22 18:56:54.935000 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:56:55.165000 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:56:55.172000 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:56:55.177000 audit: BPF prog-id=15 op=UNLOAD May 22 18:56:55.177000 audit: BPF prog-id=14 op=UNLOAD May 22 18:56:55.178000 audit: BPF prog-id=16 op=LOAD May 22 18:56:55.178000 audit: BPF prog-id=17 op=LOAD May 22 18:56:55.178000 audit: BPF prog-id=18 op=LOAD May 22 18:56:55.268000 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:56:55.268000 audit[2061]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=6 a1=7fff7a28b1c0 a2=4000 a3=0 items=0 ppid=1 pid=2061 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:56:55.268000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" May 22 18:56:54.780686 systemd[1]: Queued start job for default target multi-user.target. May 22 18:56:54.794911 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. May 22 18:56:54.796539 systemd[1]: systemd-journald.service: Deactivated successfully. May 22 18:56:55.282942 systemd[1]: Started systemd-journald.service - Journal Service. May 22 18:56:55.283000 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:56:55.284696 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 22 18:56:55.288140 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 22 18:56:55.291094 systemd[1]: Mounted media.mount - External Media Directory. May 22 18:56:55.293803 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 22 18:56:55.296039 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 22 18:56:55.299082 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 22 18:56:55.300589 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 22 18:56:55.301000 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:56:55.302612 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 22 18:56:55.302760 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 22 18:56:55.305000 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:56:55.305000 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:56:55.306255 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 22 18:56:55.306425 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 22 18:56:55.316000 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:56:55.316000 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:56:55.317324 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 22 18:56:55.317000 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:56:55.318779 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. May 22 18:56:55.319000 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:56:55.321604 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 22 18:56:55.324000 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:56:55.330199 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. May 22 18:56:55.333020 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 22 18:56:55.337641 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 22 18:56:55.341034 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 22 18:56:55.341074 systemd[1]: Reached target local-fs.target - Local File Systems. May 22 18:56:55.346210 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 22 18:56:55.349128 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 22 18:56:55.353157 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... May 22 18:56:55.365485 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 22 18:56:55.371127 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 22 18:56:55.373437 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 22 18:56:55.376142 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 22 18:56:55.382496 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 22 18:56:55.389134 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 22 18:56:55.395105 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... May 22 18:56:55.410028 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 22 18:56:55.412000 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:56:55.414431 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 22 18:56:55.417247 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 22 18:56:55.420000 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:56:55.421152 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 22 18:56:55.430957 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 22 18:56:55.432000 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:56:55.434441 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 22 18:56:55.449040 systemd-journald[2061]: Time spent on flushing to /var/log/journal/a9cdf41023da4fb9876f71bfedee1884 is 42.669ms for 1197 entries. May 22 18:56:55.449040 systemd-journald[2061]: System Journal (/var/log/journal/a9cdf41023da4fb9876f71bfedee1884) is 8M, max 2.2G, 2.2G free. May 22 18:56:55.486000 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:56:55.502000 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:56:55.531000 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:56:55.445120 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 22 18:56:55.560682 systemd-journald[2061]: Received client request to flush runtime journal. May 22 18:56:55.483342 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 22 18:56:55.560856 kernel: loop4: detected capacity change from 0 to 43464 May 22 18:56:55.500900 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. May 22 18:56:55.560951 kernel: loop4: p1 p2 p3 May 22 18:56:55.529365 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 22 18:56:55.561127 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 22 18:56:55.562000 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:56:55.618581 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 22 18:56:55.621000 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:56:55.628297 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:55.628372 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:55.630105 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:55.631609 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:55.631678 systemd-confext[2117]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:56:55.635933 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:55.643392 systemd-tmpfiles[2113]: ACLs are not supported, ignoring. May 22 18:56:55.643714 systemd-tmpfiles[2113]: ACLs are not supported, ignoring. May 22 18:56:55.646871 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 22 18:56:55.649000 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:56:55.654253 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 22 18:56:55.805501 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 22 18:56:55.831384 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 22 18:56:55.832000 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:56:55.835000 audit: BPF prog-id=19 op=LOAD May 22 18:56:55.835000 audit: BPF prog-id=20 op=LOAD May 22 18:56:55.835000 audit: BPF prog-id=21 op=LOAD May 22 18:56:55.837078 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... May 22 18:56:55.839000 audit: BPF prog-id=22 op=LOAD May 22 18:56:55.843204 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 22 18:56:55.848113 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 22 18:56:55.853560 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... May 22 18:56:55.855000 audit: BPF prog-id=23 op=LOAD May 22 18:56:55.857000 audit: BPF prog-id=24 op=LOAD May 22 18:56:55.857000 audit: BPF prog-id=25 op=LOAD May 22 18:56:55.858651 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 22 18:56:55.887102 systemd-tmpfiles[2142]: ACLs are not supported, ignoring. May 22 18:56:55.887119 systemd-tmpfiles[2142]: ACLs are not supported, ignoring. May 22 18:56:55.890843 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 22 18:56:55.892000 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:56:55.906055 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 22 18:56:55.906000 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:56:55.958941 kernel: tun: Universal TUN/TAP device driver, 1.6 May 22 18:56:55.959290 systemd[1]: modprobe@tun.service: Deactivated successfully. May 22 18:56:55.960173 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. May 22 18:56:55.961000 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:56:55.961000 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:56:55.963000 audit: BPF prog-id=26 op=LOAD May 22 18:56:55.964000 audit: BPF prog-id=27 op=LOAD May 22 18:56:55.964000 audit: BPF prog-id=28 op=LOAD May 22 18:56:55.965657 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... May 22 18:56:56.017049 systemd-nsresourced[2153]: Not setting up BPF subsystem, as functionality has been disabled at compile time. May 22 18:56:56.018563 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. May 22 18:56:56.021000 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:56:56.129360 systemd-oomd[2140]: No swap; memory pressure usage will be degraded May 22 18:56:56.130706 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. May 22 18:56:56.131000 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:56:56.145462 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 22 18:56:56.147000 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:56:56.147000 audit: BPF prog-id=7 op=UNLOAD May 22 18:56:56.147000 audit: BPF prog-id=6 op=UNLOAD May 22 18:56:56.147000 audit: BPF prog-id=29 op=LOAD May 22 18:56:56.147000 audit: BPF prog-id=30 op=LOAD May 22 18:56:56.152075 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 22 18:56:56.154876 systemd-resolved[2141]: Positive Trust Anchors: May 22 18:56:56.154887 systemd-resolved[2141]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 22 18:56:56.154891 systemd-resolved[2141]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 May 22 18:56:56.155021 systemd-resolved[2141]: 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:56:56.186616 systemd-udevd[2164]: Using default interface naming scheme 'v258'. May 22 18:56:56.240153 systemd-resolved[2141]: Using system hostname 'ci-4694.0.1-a-4719f96d26'. May 22 18:56:56.241572 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 22 18:56:56.242000 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:56:56.243474 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 22 18:56:56.360627 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 22 18:56:56.361000 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:56:56.440883 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. May 22 18:56:56.543986 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#160 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 May 22 18:56:56.549950 kernel: mousedev: PS/2 mouse device common for all mice May 22 18:56:56.621185 kernel: hv_vmbus: registering driver hyperv_fb May 22 18:56:56.647001 kernel: hv_vmbus: registering driver hv_balloon May 22 18:56:56.663234 kernel: hyperv_fb: Synthvid Version major 3, minor 5 May 22 18:56:56.663319 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 May 22 18:56:56.665087 kernel: Console: switching to colour dummy device 80x25 May 22 18:56:56.669940 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 May 22 18:56:56.670002 kernel: Console: switching to colour frame buffer device 128x48 May 22 18:56:56.679845 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. May 22 18:56:56.751242 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:56:56.763826 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 22 18:56:56.764118 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:56:56.766000 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:56:56.766000 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:56:56.769051 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:56:56.788000 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:56:56.788000 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:56:56.787135 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 22 18:56:56.787368 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:56:56.792491 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 22 18:56:56.831951 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. May 22 18:56:56.859949 kernel: loop4: detected capacity change from 0 to 43464 May 22 18:56:56.860988 kernel: loop4: p1 p2 p3 May 22 18:56:56.871948 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:56.871993 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:56.874557 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:56.874610 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:56.875968 (sd-merge)[2241]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:56:56.880986 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:56.932565 (sd-merge)[2241]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. May 22 18:56:56.932940 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. May 22 18:56:56.944147 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. May 22 18:56:56.943000 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:56:56.950060 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 22 18:56:56.973959 kernel: loop4: detected capacity change from 0 to 136912 May 22 18:56:56.976933 kernel: loop4: p1 p2 p3 May 22 18:56:56.990957 kernel: kvm_intel: Using Hyper-V Enlightened VMCS May 22 18:56:56.993704 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. May 22 18:56:56.998064 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 22 18:56:56.999782 kernel: cpu_based_exec_ctrl unsupported with eVMCS: 0x20000 May 22 18:56:57.011999 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.012059 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:57.013937 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:57.016685 systemd-sysext[2253]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:56:57.017053 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:57.020961 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.047988 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 22 18:56:57.050000 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:56:57.060936 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. May 22 18:56:57.081945 kernel: loop4: detected capacity change from 0 to 378016 May 22 18:56:57.082979 kernel: loop4: p1 p2 p3 May 22 18:56:57.106357 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.106421 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:57.109223 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:57.111684 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:57.111770 systemd-sysext[2253]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:56:57.114942 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.152941 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. May 22 18:56:57.172939 kernel: loop4: detected capacity change from 0 to 178200 May 22 18:56:57.175956 kernel: loop4: p1 p2 p3 May 22 18:56:57.179009 kernel: loop4: p1 p2 p3 May 22 18:56:57.192151 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.192207 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:57.192303 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:57.194116 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:57.194340 systemd-sysext[2253]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:56:57.196941 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.218514 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 22 18:56:57.221000 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:56:57.223199 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. May 22 18:56:57.243939 kernel: loop4: detected capacity change from 0 to 136912 May 22 18:56:57.244004 kernel: loop4: p1 p2 p3 May 22 18:56:57.245667 kernel: loop4: p1 p2 p3 May 22 18:56:57.258434 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.258486 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:57.259888 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:57.260982 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:57.261250 (sd-merge)[2285]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument May 22 18:56:57.263974 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.282941 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. May 22 18:56:57.286722 kernel: loop5: detected capacity change from 0 to 378016 May 22 18:56:57.286795 kernel: loop5: p1 p2 p3 May 22 18:56:57.308802 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.308860 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:57.310367 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:57.311434 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:57.311683 (sd-merge)[2285]: device-mapper: reload ioctl on loop5p1-verity (254:6) failed: Invalid argument May 22 18:56:57.313940 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.346938 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. May 22 18:56:57.351094 kernel: loop6: detected capacity change from 0 to 178200 May 22 18:56:57.354937 kernel: loop6: p1 p2 p3 May 22 18:56:57.358937 kernel: loop6: p1 p2 p3 May 22 18:56:57.373200 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.373260 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc May 22 18:56:57.376714 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) May 22 18:56:57.376680 (sd-merge)[2285]: device-mapper: reload ioctl on loop6p1-verity (254:7) failed: Invalid argument May 22 18:56:57.376807 kernel: device-mapper: ioctl: error adding target to table May 22 18:56:57.378947 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 22 18:56:57.407944 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. May 22 18:56:57.421811 (sd-merge)[2285]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. May 22 18:56:57.424470 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 22 18:56:57.427000 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:56:57.429585 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 22 18:56:57.464600 systemd-tmpfiles[2308]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. May 22 18:56:57.464964 systemd-tmpfiles[2308]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. May 22 18:56:57.465948 systemd-tmpfiles[2308]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 22 18:56:57.467089 systemd-tmpfiles[2308]: ACLs are not supported, ignoring. May 22 18:56:57.467170 systemd-tmpfiles[2308]: ACLs are not supported, ignoring. May 22 18:56:57.483285 systemd-tmpfiles[2308]: Detected autofs mount point /boot during canonicalization of boot. May 22 18:56:57.483296 systemd-tmpfiles[2308]: Skipping /boot May 22 18:56:57.487238 systemd-tmpfiles[2308]: Detected autofs mount point /boot during canonicalization of boot. May 22 18:56:57.487250 systemd-tmpfiles[2308]: Skipping /boot May 22 18:56:57.494803 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 22 18:56:57.495000 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:56:57.498163 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 22 18:56:57.500454 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 22 18:56:57.506487 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 22 18:56:57.512970 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 22 18:56:57.517057 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 22 18:56:57.542000 audit[2318]: AUDIT1127 pid=2318 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:56:57.547275 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 22 18:56:57.548000 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:56:57.730985 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 22 18:56:57.733000 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:56:57.842164 augenrules[2340]: No rules May 22 18:56:57.841000 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:56:57.841000 audit[2340]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff3c896d20 a2=420 a3=0 items=0 ppid=2314 pid=2340 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:56:57.841000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 May 22 18:56:57.843794 systemd[1]: audit-rules.service: Deactivated successfully. May 22 18:56:57.844130 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 22 18:56:57.938548 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 22 18:56:57.940602 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:57:02.747456 ldconfig[2316]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 22 18:57:02.759685 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 22 18:57:02.764024 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 22 18:57:02.793196 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 22 18:57:02.795241 systemd[1]: Reached target sysinit.target - System Initialization. May 22 18:57:02.799129 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 22 18:57:02.800815 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:57:02.803991 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. May 22 18:57:02.805595 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 22 18:57:02.809030 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 22 18:57:02.811995 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. May 22 18:57:02.815043 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. May 22 18:57:02.817971 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 22 18:57:02.819597 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 22 18:57:02.819639 systemd[1]: Reached target paths.target - Path Units. May 22 18:57:02.821975 systemd[1]: Reached target timers.target - Timer Units. May 22 18:57:02.823897 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 22 18:57:02.841581 systemd[1]: Starting docker.socket - Docker Socket for the API... May 22 18:57:02.844215 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 22 18:57:02.847667 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 22 18:57:02.850298 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 22 18:57:02.852364 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. May 22 18:57:02.855185 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. May 22 18:57:02.857381 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 22 18:57:02.859715 systemd[1]: Reached target sockets.target - Socket Units. May 22 18:57:02.862982 systemd[1]: Reached target basic.target - Basic System. May 22 18:57:02.866046 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 22 18:57:02.866076 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 22 18:57:02.867789 systemd[1]: Starting chronyd.service - NTP client/server... May 22 18:57:02.869988 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... May 22 18:57:02.879676 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 22 18:57:02.884659 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 22 18:57:02.888528 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 22 18:57:02.894949 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 22 18:57:02.897265 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:57:02.902735 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... May 22 18:57:02.907227 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:57:02.908680 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. May 22 18:57:02.917228 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:57:02.920212 systemd[1]: Starting iptables-restore.service - Restore iptables firewall rules... May 22 18:57:02.924716 jq[2359]: false May 22 18:57:02.928167 KVP[2362]: KVP starting; pid is:2362 May 22 18:57:02.929694 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 22 18:57:02.934589 KVP[2362]: KVP LIC Version: 3.1 May 22 18:57:02.934902 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 22 18:57:02.935045 kernel: hv_utils: KVP IC version 4.0 May 22 18:57:02.940488 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 22 18:57:02.952960 extend-filesystems[2360]: Found /dev/nvme0n1p6 May 22 18:57:02.954888 systemd[1]: Starting systemd-logind.service - User Login Management... May 22 18:57:02.956661 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 22 18:57:02.960637 systemd[1]: Starting update-engine.service - Update Engine... May 22 18:57:02.965121 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 22 18:57:02.971960 google_oslogin_nss_cache[2361]: oslogin_cache_refresh[2361]: Refreshing passwd entry cache May 22 18:57:02.972987 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 22 18:57:02.974724 oslogin_cache_refresh[2361]: Refreshing passwd entry cache May 22 18:57:02.975708 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 22 18:57:02.982349 extend-filesystems[2360]: Found /dev/nvme0n1p9 May 22 18:57:02.976597 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 22 18:57:02.976864 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 22 18:57:02.977097 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 22 18:57:02.986567 extend-filesystems[2360]: Checking size of /dev/nvme0n1p9 May 22 18:57:02.989909 google_oslogin_nss_cache[2361]: oslogin_cache_refresh[2361]: Failure getting users, quitting May 22 18:57:02.989909 google_oslogin_nss_cache[2361]: oslogin_cache_refresh[2361]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 22 18:57:02.989909 google_oslogin_nss_cache[2361]: oslogin_cache_refresh[2361]: Refreshing group entry cache May 22 18:57:02.989909 google_oslogin_nss_cache[2361]: oslogin_cache_refresh[2361]: Failure getting groups, quitting May 22 18:57:02.989909 google_oslogin_nss_cache[2361]: oslogin_cache_refresh[2361]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 22 18:57:02.987241 oslogin_cache_refresh[2361]: Failure getting users, quitting May 22 18:57:02.987259 oslogin_cache_refresh[2361]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 22 18:57:02.987299 oslogin_cache_refresh[2361]: Refreshing group entry cache May 22 18:57:02.988403 oslogin_cache_refresh[2361]: Failure getting groups, quitting May 22 18:57:02.988410 oslogin_cache_refresh[2361]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 22 18:57:02.992910 systemd[1]: google-oslogin-cache.service: Deactivated successfully. May 22 18:57:02.994063 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. May 22 18:57:03.000172 jq[2373]: true May 22 18:57:03.009280 chronyd[2352]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) May 22 18:57:03.013002 systemd[1]: motdgen.service: Deactivated successfully. May 22 18:57:03.013291 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 22 18:57:03.025201 extend-filesystems[2360]: Resized partition /dev/nvme0n1p9 May 22 18:57:03.032945 jq[2396]: true May 22 18:57:03.039330 chronyd[2352]: Timezone right/UTC failed leap second check, ignoring May 22 18:57:03.039481 chronyd[2352]: Loaded seccomp filter (level 2) May 22 18:57:03.039744 systemd[1]: Started chronyd.service - NTP client/server. May 22 18:57:03.047440 extend-filesystems[2404]: resize2fs 1.47.3 (8-Jul-2025) May 22 18:57:03.054862 update_engine[2372]: I20260522 18:57:03.054790 2372 main.cc:92] Flatcar Update Engine starting May 22 18:57:03.061945 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 6359552 to 6376955 blocks May 22 18:57:03.107524 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 6376955 May 22 18:57:03.108240 systemd-logind[2371]: New seat seat0. May 22 18:57:03.113104 systemd-logind[2371]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) May 22 18:57:03.113565 systemd[1]: Started systemd-logind.service - User Login Management. May 22 18:57:03.124331 extend-filesystems[2404]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required May 22 18:57:03.124331 extend-filesystems[2404]: old_desc_blocks = 4, new_desc_blocks = 4 May 22 18:57:03.124331 extend-filesystems[2404]: The filesystem on /dev/nvme0n1p9 is now 6376955 (4k) blocks long. May 22 18:57:03.134724 extend-filesystems[2360]: Resized filesystem in /dev/nvme0n1p9 May 22 18:57:03.126546 systemd[1]: extend-filesystems.service: Deactivated successfully. May 22 18:57:03.126867 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 22 18:57:03.138180 systemd[1]: iptables-restore.service: Deactivated successfully. May 22 18:57:03.138459 systemd[1]: Finished iptables-restore.service - Restore iptables firewall rules. May 22 18:57:03.141800 systemd[1]: Reached target network-pre.target - Preparation for Network. May 22 18:57:03.150126 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 22 18:57:03.172872 dbus-daemon[2354]: [system] SELinux support is enabled May 22 18:57:03.173075 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 22 18:57:03.188506 bash[2424]: Updated "/home/core/.ssh/authorized_keys" May 22 18:57:03.190233 dbus-daemon[2354]: [system] Successfully activated service 'org.freedesktop.systemd1' May 22 18:57:03.194191 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 22 18:57:03.203933 update_engine[2372]: I20260522 18:57:03.202219 2372 update_check_scheduler.cc:74] Next update check in 5m19s May 22 18:57:03.208045 systemd[1]: Started update-engine.service - Update Engine. May 22 18:57:03.211650 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 22 18:57:03.225546 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:57:03.225725 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 22 18:57:03.228548 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:57:03.228678 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 22 18:57:03.241954 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 22 18:57:03.439527 locksmithd[2458]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 22 18:57:03.527445 sshd_keygen[2403]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 22 18:57:03.546801 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 22 18:57:03.554161 systemd[1]: Starting issuegen.service - Generate /run/issue... May 22 18:57:03.557123 systemd-networkd[2442]: lo: Link UP May 22 18:57:03.557136 systemd-networkd[2442]: lo: Gained carrier May 22 18:57:03.558752 systemd[1]: Started systemd-networkd.service - Network Configuration. May 22 18:57:03.561126 systemd[1]: Reached target network.target - Network. May 22 18:57:03.563846 systemd[1]: Starting containerd.service - containerd container runtime... May 22 18:57:03.564884 systemd-networkd[2442]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network May 22 18:57:03.564892 systemd-networkd[2442]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 22 18:57:03.569074 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 May 22 18:57:03.570080 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 22 18:57:03.575709 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 22 18:57:03.592523 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 May 22 18:57:03.590967 systemd[1]: issuegen.service: Deactivated successfully. May 22 18:57:03.592069 systemd[1]: Finished issuegen.service - Generate /run/issue. May 22 18:57:03.603877 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 22 18:57:03.604305 kernel: hv_netvsc f8615163-0000-1000-2000-70a8a54e6723 eth0: Data path switched to VF: enP30832s1 May 22 18:57:03.610887 systemd-networkd[2442]: enP30832s1: Link UP May 22 18:57:03.611717 systemd-networkd[2442]: eth0: Link UP May 22 18:57:03.611839 systemd-networkd[2442]: eth0: Gained carrier May 22 18:57:03.611897 systemd-networkd[2442]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network May 22 18:57:03.614664 systemd-networkd[2442]: enP30832s1: Gained carrier May 22 18:57:03.622589 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 22 18:57:03.624037 systemd-networkd[2442]: eth0: DHCPv4 address 10.0.0.11/24, gateway 10.0.0.1 acquired from 168.63.129.16 May 22 18:57:03.626490 systemd[1]: Started getty@tty1.service - Getty on tty1. May 22 18:57:03.630240 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. May 22 18:57:03.633433 systemd[1]: Reached target getty.target - Login Prompts. May 22 18:57:03.641725 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 22 18:57:04.056509 coreos-metadata[2353]: May 22 18:57:04.056 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 May 22 18:57:04.067213 coreos-metadata[2353]: May 22 18:57:04.067 INFO Fetch successful May 22 18:57:04.067213 coreos-metadata[2353]: May 22 18:57:04.067 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 May 22 18:57:04.071246 coreos-metadata[2353]: May 22 18:57:04.071 INFO Fetch successful May 22 18:57:04.071596 coreos-metadata[2353]: May 22 18:57:04.071 INFO Fetching http://168.63.129.16/machine/8656ba35-664e-4eb6-a90a-276626f784f4/0f8106c6%2D0bc2%2D4bab%2D99b4%2Df0794cbe0940.%5Fci%2D4694.0.1%2Da%2D4719f96d26?comp=config&type=sharedConfig&incarnation=1: Attempt #1 May 22 18:57:04.072541 coreos-metadata[2353]: May 22 18:57:04.072 INFO Fetch successful May 22 18:57:04.072725 coreos-metadata[2353]: May 22 18:57:04.072 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 May 22 18:57:04.083086 coreos-metadata[2353]: May 22 18:57:04.083 INFO Fetch successful May 22 18:57:04.110575 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. May 22 18:57:04.112433 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 22 18:57:04.930103 containerd[2489]: time="2026-05-22T18:57:04Z" 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:57:04.931674 containerd[2489]: time="2026-05-22T18:57:04.931632930Z" level=info msg="starting containerd" revision=dea7da592f5d1d2b7755e3a161be07f43fad8f75 version=v2.2.1 May 22 18:57:04.943309 containerd[2489]: time="2026-05-22T18:57:04.943273754Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="13.544µs" May 22 18:57:04.943309 containerd[2489]: time="2026-05-22T18:57:04.943301415Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 22 18:57:04.943398 containerd[2489]: time="2026-05-22T18:57:04.943339385Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 22 18:57:04.943398 containerd[2489]: time="2026-05-22T18:57:04.943350628Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 22 18:57:04.943534 containerd[2489]: time="2026-05-22T18:57:04.943516635Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 22 18:57:04.943562 containerd[2489]: time="2026-05-22T18:57:04.943533619Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 May 22 18:57:04.943562 containerd[2489]: time="2026-05-22T18:57:04.943544788Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 22 18:57:04.943603 containerd[2489]: time="2026-05-22T18:57:04.943592245Z" 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:57:04.943627 containerd[2489]: time="2026-05-22T18:57:04.943602421Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 22 18:57:04.943793 containerd[2489]: time="2026-05-22T18:57:04.943774428Z" 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:57:04.943793 containerd[2489]: time="2026-05-22T18:57:04.943788950Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 22 18:57:04.943840 containerd[2489]: time="2026-05-22T18:57:04.943799891Z" 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:57:04.943840 containerd[2489]: time="2026-05-22T18:57:04.943809425Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 May 22 18:57:04.944005 containerd[2489]: time="2026-05-22T18:57:04.943988104Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 22 18:57:04.944066 containerd[2489]: time="2026-05-22T18:57:04.944052185Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 22 18:57:04.944198 containerd[2489]: time="2026-05-22T18:57:04.944182575Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 22 18:57:04.944225 containerd[2489]: time="2026-05-22T18:57:04.944205881Z" 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:57:04.944225 containerd[2489]: time="2026-05-22T18:57:04.944215819Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 22 18:57:04.944638 containerd[2489]: time="2026-05-22T18:57:04.944620724Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 22 18:57:04.945345 containerd[2489]: time="2026-05-22T18:57:04.945316924Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 22 18:57:04.945435 containerd[2489]: time="2026-05-22T18:57:04.945418535Z" level=info msg="metadata content store policy set" policy=shared May 22 18:57:04.977734 containerd[2489]: time="2026-05-22T18:57:04.977692053Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 22 18:57:04.977845 containerd[2489]: time="2026-05-22T18:57:04.977750035Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 22 18:57:04.977845 containerd[2489]: time="2026-05-22T18:57:04.977782982Z" level=info msg="built-in NRI default validator is disabled" May 22 18:57:04.977845 containerd[2489]: time="2026-05-22T18:57:04.977790874Z" level=info msg="runtime interface created" May 22 18:57:04.977845 containerd[2489]: time="2026-05-22T18:57:04.977794882Z" level=info msg="created NRI interface" May 22 18:57:04.977845 containerd[2489]: time="2026-05-22T18:57:04.977802718Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 May 22 18:57:05.044757 containerd[2489]: time="2026-05-22T18:57:05.044704970Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 22 18:57:05.044757 containerd[2489]: time="2026-05-22T18:57:05.044757919Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 22 18:57:05.044927 containerd[2489]: time="2026-05-22T18:57:05.044787030Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 May 22 18:57:05.044977 containerd[2489]: time="2026-05-22T18:57:05.044959279Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 22 18:57:05.045001 containerd[2489]: time="2026-05-22T18:57:05.044987156Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 22 18:57:05.045021 containerd[2489]: time="2026-05-22T18:57:05.045000579Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 22 18:57:05.045021 containerd[2489]: time="2026-05-22T18:57:05.045013304Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 22 18:57:05.045134 containerd[2489]: time="2026-05-22T18:57:05.045026717Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 22 18:57:05.045134 containerd[2489]: time="2026-05-22T18:57:05.045038062Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 22 18:57:05.045134 containerd[2489]: time="2026-05-22T18:57:05.045047667Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 22 18:57:05.045134 containerd[2489]: time="2026-05-22T18:57:05.045056203Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 22 18:57:05.045134 containerd[2489]: time="2026-05-22T18:57:05.045067657Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 22 18:57:05.045265 containerd[2489]: time="2026-05-22T18:57:05.045192145Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 22 18:57:05.045265 containerd[2489]: time="2026-05-22T18:57:05.045212738Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 22 18:57:05.045265 containerd[2489]: time="2026-05-22T18:57:05.045236533Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 22 18:57:05.045265 containerd[2489]: time="2026-05-22T18:57:05.045250369Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 22 18:57:05.045265 containerd[2489]: time="2026-05-22T18:57:05.045261517Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 22 18:57:05.045379 containerd[2489]: time="2026-05-22T18:57:05.045272377Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 22 18:57:05.045379 containerd[2489]: time="2026-05-22T18:57:05.045284140Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 22 18:57:05.045379 containerd[2489]: time="2026-05-22T18:57:05.045296210Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 22 18:57:05.045379 containerd[2489]: time="2026-05-22T18:57:05.045308129Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 May 22 18:57:05.045379 containerd[2489]: time="2026-05-22T18:57:05.045318398Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 22 18:57:05.045379 containerd[2489]: time="2026-05-22T18:57:05.045333663Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 22 18:57:05.045379 containerd[2489]: time="2026-05-22T18:57:05.045344190Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 22 18:57:05.045545 containerd[2489]: time="2026-05-22T18:57:05.045525745Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 22 18:57:05.045721 containerd[2489]: time="2026-05-22T18:57:05.045640268Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 22 18:57:05.045721 containerd[2489]: time="2026-05-22T18:57:05.045666194Z" level=info msg="Start snapshots syncer" May 22 18:57:05.045721 containerd[2489]: time="2026-05-22T18:57:05.045691640Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 22 18:57:05.046181 containerd[2489]: time="2026-05-22T18:57:05.046129503Z" 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:57:05.046407 containerd[2489]: time="2026-05-22T18:57:05.046194469Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 22 18:57:05.046407 containerd[2489]: time="2026-05-22T18:57:05.046247954Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 22 18:57:05.046407 containerd[2489]: time="2026-05-22T18:57:05.046356107Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 22 18:57:05.046407 containerd[2489]: time="2026-05-22T18:57:05.046374939Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 22 18:57:05.046407 containerd[2489]: time="2026-05-22T18:57:05.046386068Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 22 18:57:05.046563 containerd[2489]: time="2026-05-22T18:57:05.046407348Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 22 18:57:05.046563 containerd[2489]: time="2026-05-22T18:57:05.046420822Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 22 18:57:05.046563 containerd[2489]: time="2026-05-22T18:57:05.046432222Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 22 18:57:05.046563 containerd[2489]: time="2026-05-22T18:57:05.046481179Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 22 18:57:05.046563 containerd[2489]: time="2026-05-22T18:57:05.046503929Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 22 18:57:05.046563 containerd[2489]: time="2026-05-22T18:57:05.046515796Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 22 18:57:05.046563 containerd[2489]: time="2026-05-22T18:57:05.046542863Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 22 18:57:05.046563 containerd[2489]: time="2026-05-22T18:57:05.046558189Z" 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:57:05.046740 containerd[2489]: time="2026-05-22T18:57:05.046569008Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 22 18:57:05.046740 containerd[2489]: time="2026-05-22T18:57:05.046580034Z" 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:57:05.046740 containerd[2489]: time="2026-05-22T18:57:05.046590420Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 22 18:57:05.046740 containerd[2489]: time="2026-05-22T18:57:05.046601487Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 22 18:57:05.046740 containerd[2489]: time="2026-05-22T18:57:05.046613656Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 22 18:57:05.046740 containerd[2489]: time="2026-05-22T18:57:05.046626265Z" level=info msg="Connect containerd service" May 22 18:57:05.046740 containerd[2489]: time="2026-05-22T18:57:05.046651057Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 22 18:57:05.047693 containerd[2489]: time="2026-05-22T18:57:05.047662172Z" 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:57:05.053083 systemd-networkd[2442]: eth0: Gained IPv6LL May 22 18:57:05.055524 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 22 18:57:05.059551 systemd[1]: Reached target network-online.target - Network is Online. May 22 18:57:05.062365 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 22 18:57:05.066156 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... May 22 18:57:05.091509 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. May 22 18:57:05.163077 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 22 18:57:05.640745 containerd[2489]: time="2026-05-22T18:57:05.640641615Z" level=info msg="Start subscribing containerd event" May 22 18:57:05.641010 containerd[2489]: time="2026-05-22T18:57:05.640953558Z" level=info msg="Start recovering state" May 22 18:57:05.641224 containerd[2489]: time="2026-05-22T18:57:05.641200312Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 22 18:57:05.641270 containerd[2489]: time="2026-05-22T18:57:05.641253637Z" level=info msg=serving... address=/run/containerd/containerd.sock May 22 18:57:05.642230 containerd[2489]: time="2026-05-22T18:57:05.642197737Z" level=info msg="Start event monitor" May 22 18:57:05.642230 containerd[2489]: time="2026-05-22T18:57:05.642232157Z" level=info msg="Start cni network conf syncer for default" May 22 18:57:05.642323 containerd[2489]: time="2026-05-22T18:57:05.642243043Z" level=info msg="Start streaming server" May 22 18:57:05.642323 containerd[2489]: time="2026-05-22T18:57:05.642254919Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 22 18:57:05.642323 containerd[2489]: time="2026-05-22T18:57:05.642266991Z" level=info msg="runtime interface starting up..." May 22 18:57:05.642323 containerd[2489]: time="2026-05-22T18:57:05.642272916Z" level=info msg="starting plugins..." May 22 18:57:05.642323 containerd[2489]: time="2026-05-22T18:57:05.642286825Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 22 18:57:05.642428 containerd[2489]: time="2026-05-22T18:57:05.642409375Z" level=info msg="containerd successfully booted in 0.712597s" May 22 18:57:05.642836 systemd[1]: Started containerd.service - containerd container runtime. May 22 18:57:05.646397 systemd[1]: Reached target multi-user.target - Multi-User System. May 22 18:57:05.649109 systemd[1]: Startup finished in 4.647s (kernel) + 14.580s (initrd) + 17.840s (userspace) = 37.069s. May 22 18:57:05.999681 login[2492]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) May 22 18:57:06.010709 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 22 18:57:06.011681 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 22 18:57:06.015899 systemd-logind[2371]: New session '1' of user 'core' with class 'user-light' and type 'tty'. May 22 18:57:06.040440 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 22 18:57:06.046646 systemd[1]: Started session-1.scope - Session 1 of User core. May 22 18:57:06.352163 login[2493]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) May 22 18:57:06.356845 systemd-logind[2371]: New session '2' of user 'core' with class 'user-light' and type 'tty'. May 22 18:57:06.362127 systemd[1]: Started session-2.scope - Session 2 of User core. May 22 18:57:08.810981 waagent[2521]: 2026-05-22T18:57:08.810870Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.811314Z INFO Daemon Daemon OS: flatcar 4694.0.1 May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.811450Z INFO Daemon Daemon Python: 3.12.12 May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.812604Z INFO Daemon Daemon Run daemon May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.812857Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4694.0.1' May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.813499Z INFO Daemon Daemon Using waagent for provisioning May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.814187Z INFO Daemon Daemon Activate resource disk May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.814355Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.816408Z INFO Daemon Daemon Found device: None May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.816879Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.817177Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.817834Z INFO Daemon Daemon Clean protocol and wireserver endpoint May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.818262Z INFO Daemon Daemon Running default provisioning handler May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.826280Z 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:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.827896Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.828113Z INFO Daemon Daemon cloud-init is enabled: False May 22 18:57:08.838895 waagent[2521]: 2026-05-22T18:57:08.828698Z INFO Daemon Daemon Copying ovf-env.xml May 22 18:57:09.119573 waagent[2521]: 2026-05-22T18:57:09.119188Z INFO Daemon Daemon Successfully mounted dvd May 22 18:57:09.311782 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. May 22 18:57:09.313076 waagent[2521]: 2026-05-22T18:57:09.312723Z INFO Daemon Daemon Detect protocol endpoint May 22 18:57:09.313249 waagent[2521]: 2026-05-22T18:57:09.313209Z INFO Daemon Daemon Clean protocol and wireserver endpoint May 22 18:57:09.313509 waagent[2521]: 2026-05-22T18:57:09.313486Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler May 22 18:57:09.313828 waagent[2521]: 2026-05-22T18:57:09.313808Z INFO Daemon Daemon Test for route to 168.63.129.16 May 22 18:57:09.314332 waagent[2521]: 2026-05-22T18:57:09.314307Z INFO Daemon Daemon Route to 168.63.129.16 exists May 22 18:57:09.314547 waagent[2521]: 2026-05-22T18:57:09.314528Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 May 22 18:57:09.446848 waagent[2521]: 2026-05-22T18:57:09.446728Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 May 22 18:57:09.450964 waagent[2521]: 2026-05-22T18:57:09.447194Z INFO Daemon Daemon Wire protocol version:2012-11-30 May 22 18:57:09.450964 waagent[2521]: 2026-05-22T18:57:09.447500Z INFO Daemon Daemon Server preferred version:2015-04-05 May 22 18:57:09.566367 waagent[2521]: 2026-05-22T18:57:09.566264Z INFO Daemon Daemon Initializing goal state during protocol detection May 22 18:57:09.568136 waagent[2521]: 2026-05-22T18:57:09.568089Z INFO Daemon Daemon Forcing an update of the goal state. May 22 18:57:09.573878 waagent[2521]: 2026-05-22T18:57:09.573830Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] May 22 18:57:09.588101 waagent[2521]: 2026-05-22T18:57:09.588069Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.184 May 22 18:57:09.589725 waagent[2521]: 2026-05-22T18:57:09.589686Z INFO Daemon May 22 18:57:09.590469 waagent[2521]: 2026-05-22T18:57:09.590400Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 9c65f097-dd06-46ad-ad57-9932f54a1f2e eTag: 9298562845462241550 source: Fabric] May 22 18:57:09.593293 waagent[2521]: 2026-05-22T18:57:09.593263Z INFO Daemon The vmSettings originated via Fabric; will ignore them. May 22 18:57:09.594976 waagent[2521]: 2026-05-22T18:57:09.594932Z INFO Daemon May 22 18:57:09.595498 waagent[2521]: 2026-05-22T18:57:09.595472Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] May 22 18:57:09.602823 waagent[2521]: 2026-05-22T18:57:09.602782Z INFO Daemon Daemon Downloading artifacts profile blob May 22 18:57:09.747143 waagent[2521]: 2026-05-22T18:57:09.747018Z INFO Daemon Downloaded certificate {'thumbprint': 'AE9D1416DB5FDA133D77F6F8F5008406AF59D422', 'hasPrivateKey': True} May 22 18:57:09.749766 waagent[2521]: 2026-05-22T18:57:09.749723Z INFO Daemon Fetch goal state completed May 22 18:57:09.795249 waagent[2521]: 2026-05-22T18:57:09.795193Z INFO Daemon Daemon Starting provisioning May 22 18:57:09.796269 waagent[2521]: 2026-05-22T18:57:09.795605Z INFO Daemon Daemon Handle ovf-env.xml. May 22 18:57:09.796931 waagent[2521]: 2026-05-22T18:57:09.796690Z INFO Daemon Daemon Set hostname [ci-4694.0.1-a-4719f96d26] May 22 18:57:09.813348 waagent[2521]: 2026-05-22T18:57:09.813296Z INFO Daemon Daemon Publish hostname [ci-4694.0.1-a-4719f96d26] May 22 18:57:09.815157 waagent[2521]: 2026-05-22T18:57:09.815111Z INFO Daemon Daemon Examine /proc/net/route for primary interface May 22 18:57:09.816780 waagent[2521]: 2026-05-22T18:57:09.816743Z INFO Daemon Daemon Primary interface is [eth0] May 22 18:57:09.824869 systemd-networkd[2442]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network May 22 18:57:09.824879 systemd-networkd[2442]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. May 22 18:57:09.824971 systemd-networkd[2442]: eth0: DHCP lease lost May 22 18:57:09.835359 waagent[2521]: 2026-05-22T18:57:09.835307Z INFO Daemon Daemon Create user account if not exists May 22 18:57:09.836813 waagent[2521]: 2026-05-22T18:57:09.836773Z INFO Daemon Daemon User core already exists, skip useradd May 22 18:57:09.838285 waagent[2521]: 2026-05-22T18:57:09.838212Z INFO Daemon Daemon Configure sudoer May 22 18:57:09.839531 waagent[2521]: 2026-05-22T18:57:09.839496Z INFO Daemon Daemon Configure sshd May 22 18:57:09.840907 waagent[2521]: 2026-05-22T18:57:09.840865Z 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:57:09.843991 waagent[2521]: 2026-05-22T18:57:09.843882Z INFO Daemon Daemon Deploy ssh public key. May 22 18:57:09.844968 systemd-networkd[2442]: eth0: DHCPv4 address 10.0.0.11/24, gateway 10.0.0.1 acquired from 168.63.129.16 May 22 18:57:11.098574 waagent[2521]: 2026-05-22T18:57:11.098525Z INFO Daemon Daemon Provisioning complete May 22 18:57:11.111913 waagent[2521]: 2026-05-22T18:57:11.111875Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping May 22 18:57:11.115018 waagent[2521]: 2026-05-22T18:57:11.112121Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. May 22 18:57:11.115018 waagent[2521]: 2026-05-22T18:57:11.112309Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent May 22 18:57:11.229912 waagent[2603]: 2026-05-22T18:57:11.229840Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) May 22 18:57:11.230298 waagent[2603]: 2026-05-22T18:57:11.229975Z INFO ExtHandler ExtHandler OS: flatcar 4694.0.1 May 22 18:57:11.230298 waagent[2603]: 2026-05-22T18:57:11.230034Z INFO ExtHandler ExtHandler Python: 3.12.12 May 22 18:57:11.230298 waagent[2603]: 2026-05-22T18:57:11.230079Z INFO ExtHandler ExtHandler CPU Arch: x86_64 May 22 18:57:11.405314 waagent[2603]: 2026-05-22T18:57:11.405187Z 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:57:11.405445 waagent[2603]: 2026-05-22T18:57:11.405416Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file May 22 18:57:11.405516 waagent[2603]: 2026-05-22T18:57:11.405494Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 May 22 18:57:11.414747 waagent[2603]: 2026-05-22T18:57:11.414689Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] May 22 18:57:11.421729 waagent[2603]: 2026-05-22T18:57:11.421696Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.184 May 22 18:57:11.422130 waagent[2603]: 2026-05-22T18:57:11.422102Z INFO ExtHandler May 22 18:57:11.422193 waagent[2603]: 2026-05-22T18:57:11.422170Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 9d8ec80e-0ae1-4d9a-b2fa-d38d7adb2777 eTag: 9298562845462241550 source: Fabric] May 22 18:57:11.422403 waagent[2603]: 2026-05-22T18:57:11.422383Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. May 22 18:57:11.422760 waagent[2603]: 2026-05-22T18:57:11.422736Z INFO ExtHandler May 22 18:57:11.422799 waagent[2603]: 2026-05-22T18:57:11.422786Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] May 22 18:57:11.426533 waagent[2603]: 2026-05-22T18:57:11.426505Z INFO ExtHandler ExtHandler Downloading artifacts profile blob May 22 18:57:11.491554 waagent[2603]: 2026-05-22T18:57:11.491490Z INFO ExtHandler Downloaded certificate {'thumbprint': 'AE9D1416DB5FDA133D77F6F8F5008406AF59D422', 'hasPrivateKey': True} May 22 18:57:11.491947 waagent[2603]: 2026-05-22T18:57:11.491895Z INFO ExtHandler Fetch goal state completed May 22 18:57:11.505028 waagent[2603]: 2026-05-22T18:57:11.504979Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.5 27 Jan 2026 (Library: OpenSSL 3.5.5 27 Jan 2026) May 22 18:57:11.508501 waagent[2603]: 2026-05-22T18:57:11.508450Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2603 May 22 18:57:11.508628 waagent[2603]: 2026-05-22T18:57:11.508602Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** May 22 18:57:11.508892 waagent[2603]: 2026-05-22T18:57:11.508866Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** May 22 18:57:11.510030 waagent[2603]: 2026-05-22T18:57:11.509996Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4694.0.1', '', 'Flatcar Container Linux by Kinvolk'] May 22 18:57:11.510330 waagent[2603]: 2026-05-22T18:57:11.510303Z 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:57:11.510446 waagent[2603]: 2026-05-22T18:57:11.510415Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False May 22 18:57:11.510868 waagent[2603]: 2026-05-22T18:57:11.510840Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules May 22 18:57:11.512778 waagent[2603]: 2026-05-22T18:57:11.512752Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service May 22 18:57:11.512908 waagent[2603]: 2026-05-22T18:57:11.512886Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup May 22 18:57:11.518734 waagent[2603]: 2026-05-22T18:57:11.518378Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now May 22 18:57:11.523870 systemd[1]: Reload requested from client PID 2618 ('systemctl') (unit waagent.service)... May 22 18:57:11.523887 systemd[1]: Reloading... May 22 18:57:11.593956 zram_generator::config[2662]: No configuration found. May 22 18:57:11.610949 systemd-ssh-generator[2658]: Failed to query local AF_VSOCK CID: Cannot assign requested address May 22 18:57:11.663783 (sd-exec-[2643]: /usr/lib/systemd/system-generators/systemd-ssh-generator failed with exit status 1. May 22 18:57:11.838712 systemd[1]: Reloading finished in 314 ms. May 22 18:57:11.861884 waagent[2603]: 2026-05-22T18:57:11.861055Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service May 22 18:57:11.861884 waagent[2603]: 2026-05-22T18:57:11.861227Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully May 22 18:57:12.218618 waagent[2603]: 2026-05-22T18:57:12.218545Z 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:57:12.218911 waagent[2603]: 2026-05-22T18:57:12.218882Z 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:57:12.219622 waagent[2603]: 2026-05-22T18:57:12.219555Z INFO ExtHandler ExtHandler Starting env monitor service. May 22 18:57:12.219975 waagent[2603]: 2026-05-22T18:57:12.219942Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file May 22 18:57:12.220536 waagent[2603]: 2026-05-22T18:57:12.220430Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. May 22 18:57:12.220536 waagent[2603]: 2026-05-22T18:57:12.220479Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file May 22 18:57:12.220735 waagent[2603]: 2026-05-22T18:57:12.220706Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread May 22 18:57:12.220800 waagent[2603]: 2026-05-22T18:57:12.220756Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 May 22 18:57:12.220872 waagent[2603]: 2026-05-22T18:57:12.220826Z INFO ExtHandler ExtHandler Start Extension Telemetry service. May 22 18:57:12.221148 waagent[2603]: 2026-05-22T18:57:12.221118Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. May 22 18:57:12.221450 waagent[2603]: 2026-05-22T18:57:12.221424Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 May 22 18:57:12.221639 waagent[2603]: 2026-05-22T18:57:12.221615Z INFO EnvHandler ExtHandler Configure routes May 22 18:57:12.222003 waagent[2603]: 2026-05-22T18:57:12.221912Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True May 22 18:57:12.222092 waagent[2603]: 2026-05-22T18:57:12.222066Z INFO EnvHandler ExtHandler Gateway:None May 22 18:57:12.222153 waagent[2603]: 2026-05-22T18:57:12.222132Z INFO EnvHandler ExtHandler Routes:None May 22 18:57:12.222407 waagent[2603]: 2026-05-22T18:57:12.222381Z 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:57:12.222580 waagent[2603]: 2026-05-22T18:57:12.222557Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread May 22 18:57:12.223079 waagent[2603]: 2026-05-22T18:57:12.223047Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: May 22 18:57:12.223079 waagent[2603]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT May 22 18:57:12.223079 waagent[2603]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 May 22 18:57:12.223079 waagent[2603]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 May 22 18:57:12.223079 waagent[2603]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 May 22 18:57:12.223079 waagent[2603]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 May 22 18:57:12.223079 waagent[2603]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 May 22 18:57:12.231812 waagent[2603]: 2026-05-22T18:57:12.231772Z INFO ExtHandler ExtHandler May 22 18:57:12.232167 waagent[2603]: 2026-05-22T18:57:12.231852Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 7d20e45f-4106-40d7-a782-2f018ee927c8 correlation ff10c09d-3503-4e52-a02b-d7510bd967d3 created: 2026-05-22T18:56:08.273064Z] May 22 18:57:12.232257 waagent[2603]: 2026-05-22T18:57:12.232226Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. May 22 18:57:12.232873 waagent[2603]: 2026-05-22T18:57:12.232845Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 1 ms] May 22 18:57:12.259082 waagent[2603]: 2026-05-22T18:57:12.259035Z 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:57:12.259082 waagent[2603]: Try `iptables -h' or 'iptables --help' for more information.) May 22 18:57:12.260117 waagent[2603]: 2026-05-22T18:57:12.259676Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: D596F8FA-7BA4-4348-8CE3-C4BE1E95A808;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] May 22 18:57:12.365242 waagent[2603]: 2026-05-22T18:57:12.365166Z INFO MonitorHandler ExtHandler Network interfaces: May 22 18:57:12.365242 waagent[2603]: Executing ['ip', '-a', '-o', 'link']: May 22 18:57:12.365242 waagent[2603]: 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:57:12.365242 waagent[2603]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 70:a8:a5:4e:67:23 brd ff:ff:ff:ff:ff:ff\ alias Network Device\ altname enx70a8a54e6723 May 22 18:57:12.365242 waagent[2603]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 70:a8:a5:4e:67:23 brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0\ altname enp0s0\ altname ens1 May 22 18:57:12.365242 waagent[2603]: Executing ['ip', '-4', '-a', '-o', 'address']: May 22 18:57:12.365242 waagent[2603]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever May 22 18:57:12.365242 waagent[2603]: 2: eth0 inet 10.0.0.11/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever May 22 18:57:12.365242 waagent[2603]: Executing ['ip', '-6', '-a', '-o', 'address']: May 22 18:57:12.365242 waagent[2603]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever May 22 18:57:12.365242 waagent[2603]: 2: eth0 inet6 fe80::72a8:a5ff:fe4e:6723/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever May 22 18:57:12.426745 waagent[2603]: 2026-05-22T18:57:12.426682Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: May 22 18:57:12.426745 waagent[2603]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) May 22 18:57:12.426745 waagent[2603]: pkts bytes target prot opt in out source destination May 22 18:57:12.426745 waagent[2603]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) May 22 18:57:12.426745 waagent[2603]: pkts bytes target prot opt in out source destination May 22 18:57:12.426745 waagent[2603]: Chain OUTPUT (policy ACCEPT 4 packets, 406 bytes) May 22 18:57:12.426745 waagent[2603]: pkts bytes target prot opt in out source destination May 22 18:57:12.426745 waagent[2603]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 May 22 18:57:12.426745 waagent[2603]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 May 22 18:57:12.426745 waagent[2603]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW May 22 18:57:12.429536 waagent[2603]: 2026-05-22T18:57:12.429482Z INFO EnvHandler ExtHandler Current Firewall rules: May 22 18:57:12.429536 waagent[2603]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) May 22 18:57:12.429536 waagent[2603]: pkts bytes target prot opt in out source destination May 22 18:57:12.429536 waagent[2603]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) May 22 18:57:12.429536 waagent[2603]: pkts bytes target prot opt in out source destination May 22 18:57:12.429536 waagent[2603]: Chain OUTPUT (policy ACCEPT 4 packets, 406 bytes) May 22 18:57:12.429536 waagent[2603]: pkts bytes target prot opt in out source destination May 22 18:57:12.429536 waagent[2603]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 May 22 18:57:12.429536 waagent[2603]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 May 22 18:57:12.429536 waagent[2603]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW May 22 18:57:24.786202 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 22 18:57:24.787400 systemd[1]: Started sshd@0-1-10.0.0.11:22-4.175.71.9:41196.service - OpenSSH per-connection server daemon (4.175.71.9:41196). May 22 18:57:25.211749 sshd[2759]: Accepted publickey for core from 4.175.71.9 port 41196 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:57:25.212295 sshd-session[2759]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:57:25.220032 systemd[1]: Starting user@500.service - User Manager for UID 500... May 22 18:57:25.223806 systemd-logind[2371]: New session '3' of user 'core' with class 'user' and type 'tty'. May 22 18:57:25.237555 (systemd)[2763]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) May 22 18:57:25.239472 systemd-logind[2371]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. May 22 18:57:25.419744 systemd[2763]: Queued start job for default target default.target. May 22 18:57:25.429796 systemd[2763]: Created slice app.slice - User Application Slice. May 22 18:57:25.429837 systemd[2763]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. May 22 18:57:25.429852 systemd[2763]: Reached target machines.target - Virtual Machines and Containers. May 22 18:57:25.429899 systemd[2763]: Reached target paths.target - Paths. May 22 18:57:25.429937 systemd[2763]: Reached target timers.target - Timers. May 22 18:57:25.431006 systemd[2763]: Starting dbus.socket - D-Bus User Message Bus Socket... May 22 18:57:25.432371 systemd[2763]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. May 22 18:57:25.436029 systemd[2763]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... May 22 18:57:25.445009 systemd[2763]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 22 18:57:25.445092 systemd[2763]: Reached target sockets.target - Sockets. May 22 18:57:25.446248 systemd[2763]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. May 22 18:57:25.446451 systemd[2763]: Reached target basic.target - Basic System. May 22 18:57:25.446552 systemd[2763]: Reached target default.target - Main User Target. May 22 18:57:25.446630 systemd[2763]: Startup finished in 202ms. May 22 18:57:25.446760 systemd[1]: Started user@500.service - User Manager for UID 500. May 22 18:57:25.452103 systemd[1]: Started session-3.scope - Session 3 of User core. May 22 18:57:25.498798 systemd[1]: Started sshd@1-2-10.0.0.11:22-4.175.71.9:41210.service - OpenSSH per-connection server daemon (4.175.71.9:41210). May 22 18:57:25.579032 sshd[2777]: Accepted publickey for core from 4.175.71.9 port 41210 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:57:25.580216 sshd-session[2777]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:57:25.584676 systemd-logind[2371]: New session '5' of user 'core' with class 'user' and type 'tty'. May 22 18:57:25.594116 systemd[1]: Started session-5.scope - Session 5 of User core. May 22 18:57:25.620367 sshd[2781]: Connection closed by 4.175.71.9 port 41210 May 22 18:57:25.621065 sshd-session[2777]: pam_unix(sshd:session): session closed for user core May 22 18:57:25.624262 systemd[1]: sshd@1-2-10.0.0.11:22-4.175.71.9:41210.service: Deactivated successfully. May 22 18:57:25.625739 systemd[1]: session-5.scope: Deactivated successfully. May 22 18:57:25.626439 systemd-logind[2371]: Session 5 logged out. Waiting for processes to exit. May 22 18:57:25.627641 systemd-logind[2371]: Removed session 5. May 22 18:57:25.647394 systemd[1]: Started sshd@2-4097-10.0.0.11:22-4.175.71.9:41224.service - OpenSSH per-connection server daemon (4.175.71.9:41224). May 22 18:57:25.735278 sshd[2787]: Accepted publickey for core from 4.175.71.9 port 41224 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:57:25.736419 sshd-session[2787]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:57:25.740954 systemd-logind[2371]: New session '6' of user 'core' with class 'user' and type 'tty'. May 22 18:57:25.747136 systemd[1]: Started session-6.scope - Session 6 of User core. May 22 18:57:25.771247 sshd[2791]: Connection closed by 4.175.71.9 port 41224 May 22 18:57:25.772884 sshd-session[2787]: pam_unix(sshd:session): session closed for user core May 22 18:57:25.774840 systemd[1]: sshd@2-4097-10.0.0.11:22-4.175.71.9:41224.service: Deactivated successfully. May 22 18:57:25.776446 systemd[1]: session-6.scope: Deactivated successfully. May 22 18:57:25.778259 systemd-logind[2371]: Session 6 logged out. Waiting for processes to exit. May 22 18:57:25.779210 systemd-logind[2371]: Removed session 6. May 22 18:57:25.790410 systemd[1]: Started sshd@3-3-10.0.0.11:22-4.175.71.9:41226.service - OpenSSH per-connection server daemon (4.175.71.9:41226). May 22 18:57:25.867377 sshd[2797]: Accepted publickey for core from 4.175.71.9 port 41226 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:57:25.868486 sshd-session[2797]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:57:25.872705 systemd-logind[2371]: New session '7' of user 'core' with class 'user' and type 'tty'. May 22 18:57:25.880099 systemd[1]: Started session-7.scope - Session 7 of User core. May 22 18:57:25.911115 sshd[2801]: Connection closed by 4.175.71.9 port 41226 May 22 18:57:25.912072 sshd-session[2797]: pam_unix(sshd:session): session closed for user core May 22 18:57:25.915116 systemd[1]: sshd@3-3-10.0.0.11:22-4.175.71.9:41226.service: Deactivated successfully. May 22 18:57:25.916639 systemd[1]: session-7.scope: Deactivated successfully. May 22 18:57:25.918044 systemd-logind[2371]: Session 7 logged out. Waiting for processes to exit. May 22 18:57:25.918698 systemd-logind[2371]: Removed session 7. May 22 18:57:25.930354 systemd[1]: Started sshd@4-4098-10.0.0.11:22-4.175.71.9:41234.service - OpenSSH per-connection server daemon (4.175.71.9:41234). May 22 18:57:26.004982 sshd[2807]: Accepted publickey for core from 4.175.71.9 port 41234 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:57:26.006151 sshd-session[2807]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:57:26.009983 systemd-logind[2371]: New session '8' of user 'core' with class 'user' and type 'tty'. May 22 18:57:26.021117 systemd[1]: Started session-8.scope - Session 8 of User core. May 22 18:57:26.188477 sudo[2812]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 22 18:57:26.188729 sudo[2812]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 22 18:57:26.200824 sudo[2812]: pam_unix(sudo:session): session closed for user root May 22 18:57:26.209298 sshd[2811]: Connection closed by 4.175.71.9 port 41234 May 22 18:57:26.210134 sshd-session[2807]: pam_unix(sshd:session): session closed for user core May 22 18:57:26.213102 systemd[1]: sshd@4-4098-10.0.0.11:22-4.175.71.9:41234.service: Deactivated successfully. May 22 18:57:26.214565 systemd[1]: session-8.scope: Deactivated successfully. May 22 18:57:26.215365 systemd-logind[2371]: Session 8 logged out. Waiting for processes to exit. May 22 18:57:26.216617 systemd-logind[2371]: Removed session 8. May 22 18:57:26.226526 systemd[1]: Started sshd@5-4-10.0.0.11:22-4.175.71.9:41236.service - OpenSSH per-connection server daemon (4.175.71.9:41236). May 22 18:57:26.307265 sshd[2819]: Accepted publickey for core from 4.175.71.9 port 41236 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:57:26.308418 sshd-session[2819]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:57:26.312944 systemd-logind[2371]: New session '9' of user 'core' with class 'user' and type 'tty'. May 22 18:57:26.319103 systemd[1]: Started session-9.scope - Session 9 of User core. May 22 18:57:26.339311 sudo[2825]: 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:57:26.339496 sudo[2825]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 22 18:57:26.341123 sudo[2825]: pam_unix(sudo:session): session closed for user root May 22 18:57:26.347493 sudo[2824]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 22 18:57:26.347728 sudo[2824]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 22 18:57:26.354301 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 22 18:57:26.384000 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:57:26.388063 kernel: kauditd_printk_skb: 74 callbacks suppressed May 22 18:57:26.388085 kernel: audit: type=1305 audit(1779476246.384:170): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 May 22 18:57:26.384000 audit[2849]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffdc2280570 a2=420 a3=0 items=0 ppid=2830 pid=2849 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:57:26.390735 sudo[2824]: pam_unix(sudo:session): session closed for user root May 22 18:57:26.388874 systemd[1]: audit-rules.service: Deactivated successfully. May 22 18:57:26.393378 augenrules[2849]: No rules May 22 18:57:26.389162 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 22 18:57:26.397245 kernel: audit: type=1300 audit(1779476246.384:170): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffdc2280570 a2=420 a3=0 items=0 ppid=2830 pid=2849 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:57:26.384000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 May 22 18:57:26.399404 kernel: audit: type=1327 audit(1779476246.384:170): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 May 22 18:57:26.387000 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:57:26.402622 kernel: audit: type=1130 audit(1779476246.387:171): 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:57:26.387000 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:57:26.405701 kernel: audit: type=1131 audit(1779476246.387:172): 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:57:26.387000 audit[2824]: AUDIT1106 pid=2824 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:57:26.411101 kernel: audit: type=1106 audit(1779476246.387:173): pid=2824 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:57:26.410763 systemd[1]: sshd@5-4-10.0.0.11:22-4.175.71.9:41236.service: Deactivated successfully. May 22 18:57:26.408070 sshd-session[2819]: pam_unix(sshd:session): session closed for user core May 22 18:57:26.411243 sshd[2823]: Connection closed by 4.175.71.9 port 41236 May 22 18:57:26.387000 audit[2824]: AUDIT1104 pid=2824 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:57:26.416447 kernel: audit: type=1104 audit(1779476246.387:174): pid=2824 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:57:26.413273 systemd[1]: session-9.scope: Deactivated successfully. May 22 18:57:26.415089 systemd-logind[2371]: Session 9 logged out. Waiting for processes to exit. May 22 18:57:26.405000 audit[2819]: AUDIT1106 pid=2819 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:57:26.417252 systemd-logind[2371]: Removed session 9. May 22 18:57:26.421539 kernel: audit: type=1106 audit(1779476246.405:175): pid=2819 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:57:26.405000 audit[2819]: AUDIT1104 pid=2819 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:57:26.423025 kernel: audit: type=1104 audit(1779476246.405:176): pid=2819 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:57:26.410000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4-10.0.0.11:22-4.175.71.9:41236 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:57:26.429414 kernel: audit: type=1131 audit(1779476246.410:177): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4-10.0.0.11:22-4.175.71.9:41236 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:57:26.438602 systemd[1]: Started sshd@6-5-10.0.0.11:22-4.175.71.9:41244.service - OpenSSH per-connection server daemon (4.175.71.9:41244). May 22 18:57:26.437000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-5-10.0.0.11:22-4.175.71.9:41244 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:57:26.518000 audit[2858]: AUDIT1101 pid=2858 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:57:26.519704 sshd[2858]: Accepted publickey for core from 4.175.71.9 port 41244 ssh2: RSA SHA256:oq6j8+Ssn5o/4lLcT6vePq6kkcKFE4sZ4X55nkDctu4 May 22 18:57:26.519000 audit[2858]: AUDIT1103 pid=2858 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:57:26.519000 audit[2858]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7ffe297b9ad0 a2=3 a3=0 items=0 ppid=1 pid=2858 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:57:26.519000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D May 22 18:57:26.520889 sshd-session[2858]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 22 18:57:26.525256 systemd-logind[2371]: New session '10' of user 'core' with class 'user' and type 'tty'. May 22 18:57:26.535129 systemd[1]: Started session-10.scope - Session 10 of User core. May 22 18:57:26.536000 audit[2858]: AUDIT1105 pid=2858 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:57:26.538000 audit[2862]: AUDIT1103 pid=2862 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:57:26.569000 audit[2864]: AUDIT1101 pid=2864 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' May 22 18:57:26.570445 sudo[2864]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/nft --json list ruleset May 22 18:57:26.569000 audit[2864]: AUDIT1110 pid=2864 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' May 22 18:57:26.570694 sudo[2864]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 22 18:57:26.569000 audit[2864]: AUDIT1105 pid=2864 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' May 22 18:57:26.575624 sudo[2864]: pam_unix(sudo:session): session closed for user root May 22 18:57:26.574000 audit[2864]: AUDIT1106 pid=2864 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' May 22 18:57:26.574000 audit[2864]: AUDIT1104 pid=2864 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' May 22 18:57:26.585056 sshd[2862]: Connection closed by 4.175.71.9 port 41244 May 22 18:57:26.585514 sshd-session[2858]: pam_unix(sshd:session): session closed for user core May 22 18:57:26.585000 audit[2858]: AUDIT1106 pid=2858 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:57:26.585000 audit[2858]: AUDIT1104 pid=2858 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:57:26.588540 systemd[1]: sshd@6-5-10.0.0.11:22-4.175.71.9:41244.service: Deactivated successfully. May 22 18:57:26.587000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-5-10.0.0.11:22-4.175.71.9:41244 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 22 18:57:26.590111 systemd[1]: session-10.scope: Deactivated successfully. May 22 18:57:26.590820 systemd-logind[2371]: Session 10 logged out. Waiting for processes to exit. May 22 18:57:26.592122 systemd-logind[2371]: Removed session 10. May 22 18:57:26.823348 chronyd[2352]: Selected source PHC0