Oct 23 00:23:24.327109 kernel: Linux version 6.12.113-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 Thu Oct 22 22:16:03 -00 2026 Oct 23 00:23:24.327142 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=b43ade646e91e9e680533d5f7ade45cc03aa19a17b73a6ed41a2e97e5811fd56 Oct 23 00:23:24.327153 kernel: BIOS-provided physical RAM map: Oct 23 00:23:24.327160 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Oct 23 00:23:24.327169 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Oct 23 00:23:24.327176 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000044fdfff] usable Oct 23 00:23:24.327185 kernel: BIOS-e820: [mem 0x00000000044fe000-0x00000000048fdfff] reserved Oct 23 00:23:24.327192 kernel: BIOS-e820: [mem 0x00000000048fe000-0x000000003ff1efff] usable Oct 23 00:23:24.327199 kernel: BIOS-e820: [mem 0x000000003ff1f000-0x000000003ffc8fff] reserved Oct 23 00:23:24.327207 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Oct 23 00:23:24.327213 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Oct 23 00:23:24.327220 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Oct 23 00:23:24.327227 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable Oct 23 00:23:24.327235 kernel: printk: legacy bootconsole [earlyser0] enabled Oct 23 00:23:24.327244 kernel: NX (Execute Disable) protection: active Oct 23 00:23:24.327252 kernel: APIC: Static calls initialized Oct 23 00:23:24.327260 kernel: efi: EFI v2.7 by Microsoft Oct 23 00:23:24.327269 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff88000 SMBIOS 3.0=0x3ff86000 MEMATTR=0x3ea79798 RNG=0x3ffd2018 Oct 23 00:23:24.327277 kernel: random: crng init done Oct 23 00:23:24.327284 kernel: secureboot: Secure boot disabled Oct 23 00:23:24.327291 kernel: SMBIOS 3.1.0 present. Oct 23 00:23:24.327298 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Oct 23 00:23:24.327305 kernel: DMI: Memory slots populated: 2/2 Oct 23 00:23:24.327312 kernel: Hypervisor detected: Microsoft Hyper-V Oct 23 00:23:24.327320 kernel: Hyper-V: privilege flags low 0xae7f, high 0x3b8030, hints 0x9e4e24, misc 0xe0bed7b2 Oct 23 00:23:24.327328 kernel: Hyper-V: Nested features: 0x3e0101 Oct 23 00:23:24.327335 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Oct 23 00:23:24.327343 kernel: Hyper-V: Using hypercall for remote TLB flush Oct 23 00:23:24.327352 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Oct 23 00:23:24.327360 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Oct 23 00:23:24.327367 kernel: tsc: Detected 2299.999 MHz processor Oct 23 00:23:24.327374 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 23 00:23:24.327383 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 23 00:23:24.327391 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x10000000000 Oct 23 00:23:24.327408 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Oct 23 00:23:24.327417 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 23 00:23:24.327427 kernel: e820: update [mem 0x48000000-0xffffffff] usable ==> reserved Oct 23 00:23:24.327435 kernel: last_pfn = 0x40000 max_arch_pfn = 0x10000000000 Oct 23 00:23:24.327443 kernel: Using GB pages for direct mapping Oct 23 00:23:24.327451 kernel: ACPI: Early table checksum verification disabled Oct 23 00:23:24.327462 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Oct 23 00:23:24.327472 kernel: ACPI: XSDT 0x000000003FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 23 00:23:24.327480 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 23 00:23:24.327489 kernel: ACPI: DSDT 0x000000003FFD6000 01E22B (v02 MSFTVM DSDT01 00000001 INTL 20230628) Oct 23 00:23:24.327497 kernel: ACPI: FACS 0x000000003FFFE000 000040 Oct 23 00:23:24.327506 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 23 00:23:24.327514 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 23 00:23:24.327524 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 23 00:23:24.327532 kernel: ACPI: APIC 0x000000003FFD5000 000058 (v05 HVLITE HVLITETB 00000000 MSHV 00000000) Oct 23 00:23:24.327540 kernel: ACPI: SRAT 0x000000003FFD4000 0000A0 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) Oct 23 00:23:24.327548 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 23 00:23:24.327556 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Oct 23 00:23:24.327565 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff422a] Oct 23 00:23:24.327574 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Oct 23 00:23:24.327584 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Oct 23 00:23:24.327592 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Oct 23 00:23:24.327600 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Oct 23 00:23:24.327608 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5057] Oct 23 00:23:24.327616 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd409f] Oct 23 00:23:24.327624 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Oct 23 00:23:24.327632 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Oct 23 00:23:24.327641 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] Oct 23 00:23:24.327650 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00001000-0x2bfffffff] Oct 23 00:23:24.327659 kernel: NODE_DATA(0) allocated [mem 0x2bfff8dc0-0x2bfffffff] Oct 23 00:23:24.327668 kernel: Zone ranges: Oct 23 00:23:24.327676 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 23 00:23:24.327684 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Oct 23 00:23:24.327692 kernel: Normal [mem 0x0000000100000000-0x00000002bfffffff] Oct 23 00:23:24.327701 kernel: Device empty Oct 23 00:23:24.327709 kernel: Movable zone start for each node Oct 23 00:23:24.327718 kernel: Early memory node ranges Oct 23 00:23:24.327738 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Oct 23 00:23:24.327747 kernel: node 0: [mem 0x0000000000100000-0x00000000044fdfff] Oct 23 00:23:24.327756 kernel: node 0: [mem 0x00000000048fe000-0x000000003ff1efff] Oct 23 00:23:24.327763 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Oct 23 00:23:24.327771 kernel: node 0: [mem 0x0000000100000000-0x00000002bfffffff] Oct 23 00:23:24.327781 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff] Oct 23 00:23:24.327789 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 23 00:23:24.327797 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Oct 23 00:23:24.327806 kernel: On node 0, zone DMA32: 1024 pages in unavailable ranges Oct 23 00:23:24.327815 kernel: On node 0, zone DMA32: 224 pages in unavailable ranges Oct 23 00:23:24.327823 kernel: ACPI: PM-Timer IO Port: 0x408 Oct 23 00:23:24.327832 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Oct 23 00:23:24.327841 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Oct 23 00:23:24.327849 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 23 00:23:24.327857 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 23 00:23:24.327866 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Oct 23 00:23:24.327874 kernel: TSC deadline timer available Oct 23 00:23:24.327883 kernel: CPU topo: Max. logical packages: 1 Oct 23 00:23:24.327891 kernel: CPU topo: Max. logical dies: 1 Oct 23 00:23:24.327901 kernel: CPU topo: Max. dies per package: 1 Oct 23 00:23:24.327909 kernel: CPU topo: Max. threads per core: 2 Oct 23 00:23:24.327917 kernel: CPU topo: Num. cores per package: 1 Oct 23 00:23:24.327925 kernel: CPU topo: Num. threads per package: 2 Oct 23 00:23:24.327932 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs Oct 23 00:23:24.327941 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Oct 23 00:23:24.327949 kernel: Booting paravirtualized kernel on Hyper-V Oct 23 00:23:24.327960 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 23 00:23:24.327968 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Oct 23 00:23:24.327977 kernel: percpu: Embedded 60 pages/cpu s208408 r8192 d29160 u1048576 Oct 23 00:23:24.327985 kernel: pcpu-alloc: s208408 r8192 d29160 u1048576 alloc=1*2097152 Oct 23 00:23:24.327993 kernel: pcpu-alloc: [0] 0 1 Oct 23 00:23:24.328001 kernel: Hyper-V: PV spinlocks enabled Oct 23 00:23:24.328009 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 23 00:23:24.328020 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=b43ade646e91e9e680533d5f7ade45cc03aa19a17b73a6ed41a2e97e5811fd56 Oct 23 00:23:24.328028 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Oct 23 00:23:24.328037 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 23 00:23:24.328045 kernel: Fallback order for Node 0: 0 Oct 23 00:23:24.328054 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2095807 Oct 23 00:23:24.328063 kernel: Policy zone: Normal Oct 23 00:23:24.328071 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 23 00:23:24.328080 kernel: software IO TLB: area num 2. Oct 23 00:23:24.328088 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 23 00:23:24.328096 kernel: ftrace: allocating 41514 entries in 164 pages Oct 23 00:23:24.328104 kernel: ftrace: allocated 164 pages with 3 groups Oct 23 00:23:24.328112 kernel: Dynamic Preempt: voluntary Oct 23 00:23:24.328120 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 23 00:23:24.328130 kernel: rcu: RCU event tracing is enabled. Oct 23 00:23:24.328147 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 23 00:23:24.328156 kernel: Trampoline variant of Tasks RCU enabled. Oct 23 00:23:24.328166 kernel: Rude variant of Tasks RCU enabled. Oct 23 00:23:24.328175 kernel: Tracing variant of Tasks RCU enabled. Oct 23 00:23:24.328183 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 23 00:23:24.328192 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 23 00:23:24.328200 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 23 00:23:24.328210 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 23 00:23:24.328219 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 23 00:23:24.328230 kernel: Using NULL legacy PIC Oct 23 00:23:24.328239 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0 Oct 23 00:23:24.328247 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 23 00:23:24.328256 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 23 00:23:24.328266 kernel: Console: colour dummy device 80x25 Oct 23 00:23:24.328275 kernel: printk: legacy console [tty1] enabled Oct 23 00:23:24.328283 kernel: printk: legacy console [ttyS0] enabled Oct 23 00:23:24.328292 kernel: printk: legacy bootconsole [earlyser0] disabled Oct 23 00:23:24.328301 kernel: ACPI: Core revision 20240827 Oct 23 00:23:24.328310 kernel: Failed to register legacy timer interrupt Oct 23 00:23:24.328319 kernel: APIC: Switch to symmetric I/O mode setup Oct 23 00:23:24.328330 kernel: x2apic enabled Oct 23 00:23:24.328338 kernel: APIC: Switched APIC routing to: physical x2apic Oct 23 00:23:24.328346 kernel: Hyper-V: Host Build 10.0.26102.3704-3-0 Oct 23 00:23:24.328355 kernel: Hyper-V: enabling crash_kexec_post_notifiers Oct 23 00:23:24.328364 kernel: Hyper-V: Disabling IBT because of Hyper-V bug Oct 23 00:23:24.328373 kernel: Hyper-V: Using IPI hypercalls Oct 23 00:23:24.328382 kernel: APIC: send_IPI() replaced with hv_send_ipi() Oct 23 00:23:24.328392 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Oct 23 00:23:24.328402 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Oct 23 00:23:24.328411 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Oct 23 00:23:24.328420 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Oct 23 00:23:24.328428 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Oct 23 00:23:24.328437 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2127345424d, max_idle_ns: 440795318347 ns Oct 23 00:23:24.328446 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4599.99 BogoMIPS (lpj=2299999) Oct 23 00:23:24.328457 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Oct 23 00:23:24.328466 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Oct 23 00:23:24.328475 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Oct 23 00:23:24.328484 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 23 00:23:24.328491 kernel: Spectre V2 : Mitigation: Retpolines Oct 23 00:23:24.328499 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Oct 23 00:23:24.328508 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Oct 23 00:23:24.328516 kernel: RETBleed: Vulnerable Oct 23 00:23:24.328524 kernel: Speculative Store Bypass: Vulnerable Oct 23 00:23:24.328533 kernel: active return thunk: its_return_thunk Oct 23 00:23:24.328541 kernel: ITS: Mitigation: Aligned branch/return thunks Oct 23 00:23:24.328550 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 23 00:23:24.328558 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 23 00:23:24.328567 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 23 00:23:24.328576 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Oct 23 00:23:24.328584 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Oct 23 00:23:24.328592 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Oct 23 00:23:24.328600 kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' Oct 23 00:23:24.328608 kernel: x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' Oct 23 00:23:24.328618 kernel: x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' Oct 23 00:23:24.328626 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 23 00:23:24.328635 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Oct 23 00:23:24.328643 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Oct 23 00:23:24.328651 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Oct 23 00:23:24.328660 kernel: x86/fpu: xstate_offset[11]: 2432, xstate_sizes[11]: 16 Oct 23 00:23:24.328669 kernel: x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 Oct 23 00:23:24.328677 kernel: x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 Oct 23 00:23:24.328686 kernel: x86/fpu: Enabled xstate features 0x608e7, context size is 10752 bytes, using 'compacted' format. Oct 23 00:23:24.328694 kernel: Freeing SMP alternatives memory: 36K Oct 23 00:23:24.328702 kernel: pid_max: default: 32768 minimum: 301 Oct 23 00:23:24.328711 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 23 00:23:24.328727 kernel: landlock: Up and running. Oct 23 00:23:24.328736 kernel: SELinux: Initializing. Oct 23 00:23:24.328744 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 23 00:23:24.328754 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 23 00:23:24.328762 kernel: smpboot: CPU0: Intel INTEL(R) XEON(R) PLATINUM 8573C (family: 0x6, model: 0xcf, stepping: 0x2) Oct 23 00:23:24.328771 kernel: Performance Events: unsupported p6 CPU model 207 no PMU driver, software events only. Oct 23 00:23:24.328780 kernel: signal: max sigframe size: 11952 Oct 23 00:23:24.328789 kernel: rcu: Hierarchical SRCU implementation. Oct 23 00:23:24.328799 kernel: rcu: Max phase no-delay instances is 400. Oct 23 00:23:24.328808 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 23 00:23:24.328816 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Oct 23 00:23:24.328825 kernel: smp: Bringing up secondary CPUs ... Oct 23 00:23:24.328834 kernel: smpboot: x86: Booting SMP configuration: Oct 23 00:23:24.328844 kernel: .... node #0, CPUs: #1 Oct 23 00:23:24.328853 kernel: smp: Brought up 1 node, 2 CPUs Oct 23 00:23:24.328861 kernel: smpboot: Total of 2 processors activated (9199.99 BogoMIPS) Oct 23 00:23:24.328872 kernel: Memory: 8073188K/8383228K available (14336K kernel code, 2476K rwdata, 32660K rodata, 16144K init, 1884K bss, 303780K reserved, 0K cma-reserved) Oct 23 00:23:24.328880 kernel: devtmpfs: initialized Oct 23 00:23:24.328889 kernel: x86/mm: Memory block size: 128MB Oct 23 00:23:24.328898 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Oct 23 00:23:24.328907 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 23 00:23:24.328916 kernel: pinctrl core: initialized pinctrl subsystem Oct 23 00:23:24.328926 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 23 00:23:24.328936 kernel: audit: initializing netlink subsys (disabled) Oct 23 00:23:24.328944 kernel: audit: type=2000 audit(1792714996.083:1): state=initialized audit_enabled=0 res=1 Oct 23 00:23:24.328953 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 23 00:23:24.328961 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 23 00:23:24.328969 kernel: cpuidle: using governor menu Oct 23 00:23:24.328977 kernel: efi: Freeing EFI boot services memory: 20180K Oct 23 00:23:24.328986 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 23 00:23:24.328997 kernel: dca service started, version 1.12.1 Oct 23 00:23:24.329006 kernel: e820: reserve RAM buffer [mem 0x044fe000-0x07ffffff] Oct 23 00:23:24.329015 kernel: e820: reserve RAM buffer [mem 0x3ff1f000-0x3fffffff] Oct 23 00:23:24.329024 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 23 00:23:24.329032 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 23 00:23:24.329041 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Oct 23 00:23:24.329050 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 23 00:23:24.329059 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 23 00:23:24.329069 kernel: ACPI: Added _OSI(Module Device) Oct 23 00:23:24.329078 kernel: ACPI: Added _OSI(Processor Device) Oct 23 00:23:24.329087 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 23 00:23:24.329096 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 23 00:23:24.329104 kernel: ACPI: Interpreter enabled Oct 23 00:23:24.329112 kernel: ACPI: PM: (supports S0 S5) Oct 23 00:23:24.329122 kernel: ACPI: Using IOAPIC for interrupt routing Oct 23 00:23:24.329131 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 23 00:23:24.329139 kernel: PCI: Ignoring E820 reservations for host bridge windows Oct 23 00:23:24.329148 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Oct 23 00:23:24.329157 kernel: iommu: Default domain type: Translated Oct 23 00:23:24.329165 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 23 00:23:24.329174 kernel: efivars: Registered efivars operations Oct 23 00:23:24.329184 kernel: PCI: Using ACPI for IRQ routing Oct 23 00:23:24.329194 kernel: PCI: System does not support PCI Oct 23 00:23:24.329203 kernel: vgaarb: loaded Oct 23 00:23:24.329212 kernel: clocksource: Switched to clocksource tsc-early Oct 23 00:23:24.329220 kernel: VFS: Disk quotas dquot_6.6.0 Oct 23 00:23:24.329228 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 23 00:23:24.329237 kernel: pnp: PnP ACPI init Oct 23 00:23:24.329247 kernel: pnp: PnP ACPI: found 3 devices Oct 23 00:23:24.329255 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 23 00:23:24.329264 kernel: NET: Registered PF_INET protocol family Oct 23 00:23:24.329273 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) Oct 23 00:23:24.329283 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) Oct 23 00:23:24.329292 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 23 00:23:24.329301 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 23 00:23:24.329311 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Oct 23 00:23:24.329319 kernel: TCP: Hash tables configured (established 65536 bind 65536) Oct 23 00:23:24.329327 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) Oct 23 00:23:24.329336 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) Oct 23 00:23:24.329345 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 23 00:23:24.329354 kernel: NET: Registered PF_XDP protocol family Oct 23 00:23:24.329363 kernel: PCI: CLS 0 bytes, default 64 Oct 23 00:23:24.329373 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Oct 23 00:23:24.329381 kernel: software IO TLB: mapped [mem 0x000000003a95c000-0x000000003e95c000] (64MB) Oct 23 00:23:24.329391 kernel: RAPL PMU: API unit is 2^-32 Joules, 1 fixed counters, 10737418240 ms ovfl timer Oct 23 00:23:24.329400 kernel: RAPL PMU: hw unit of domain psys 2^-0 Joules Oct 23 00:23:24.329409 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2127345424d, max_idle_ns: 440795318347 ns Oct 23 00:23:24.329418 kernel: clocksource: Switched to clocksource tsc Oct 23 00:23:24.329427 kernel: Initialise system trusted keyrings Oct 23 00:23:24.329439 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 Oct 23 00:23:24.329450 kernel: Key type asymmetric registered Oct 23 00:23:24.329459 kernel: Asymmetric key parser 'x509' registered Oct 23 00:23:24.329469 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 23 00:23:24.329480 kernel: io scheduler mq-deadline registered Oct 23 00:23:24.329490 kernel: io scheduler kyber registered Oct 23 00:23:24.329500 kernel: io scheduler bfq registered Oct 23 00:23:24.329510 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 23 00:23:24.329522 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 23 00:23:24.329531 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 23 00:23:24.329541 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Oct 23 00:23:24.329550 kernel: serial8250: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A Oct 23 00:23:24.329560 kernel: ACPI: bus type drm_connector registered Oct 23 00:23:24.329569 kernel: i8042: PNP: No PS/2 controller found. Oct 23 00:23:24.329841 kernel: rtc_cmos 00:02: registered as rtc0 Oct 23 00:23:24.329982 kernel: rtc_cmos 00:02: setting system clock to 2026-10-23T00:23:18 UTC (1792714998) Oct 23 00:23:24.330115 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Oct 23 00:23:24.330125 kernel: intel_pstate: Intel P-state driver initializing Oct 23 00:23:24.330135 kernel: efifb: probing for efifb Oct 23 00:23:24.330145 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Oct 23 00:23:24.330157 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Oct 23 00:23:24.330168 kernel: efifb: scrolling: redraw Oct 23 00:23:24.330177 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Oct 23 00:23:24.330187 kernel: Console: switching to colour frame buffer device 128x48 Oct 23 00:23:24.330195 kernel: fb0: EFI VGA frame buffer device Oct 23 00:23:24.330204 kernel: pstore: Using crash dump compression: deflate Oct 23 00:23:24.330212 kernel: pstore: Registered efi_pstore as persistent store backend Oct 23 00:23:24.330221 kernel: NET: Registered PF_INET6 protocol family Oct 23 00:23:24.330234 kernel: Segment Routing with IPv6 Oct 23 00:23:24.330242 kernel: In-situ OAM (IOAM) with IPv6 Oct 23 00:23:24.330251 kernel: NET: Registered PF_PACKET protocol family Oct 23 00:23:24.330259 kernel: Key type dns_resolver registered Oct 23 00:23:24.330269 kernel: IPI shorthand broadcast: enabled Oct 23 00:23:24.330278 kernel: sched_clock: Marking stable (2045072098, 102118121)->(2454205553, -307015334) Oct 23 00:23:24.330286 kernel: registered taskstats version 1 Oct 23 00:23:24.330298 kernel: Loading compiled-in X.509 certificates Oct 23 00:23:24.330307 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.113-flatcar: 390a824fd98845d92c6713685ebd1f1a6ac230c4' Oct 23 00:23:24.330317 kernel: Demotion targets for Node 0: null Oct 23 00:23:24.330326 kernel: Key type .fscrypt registered Oct 23 00:23:24.330336 kernel: Key type fscrypt-provisioning registered Oct 23 00:23:24.330344 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 23 00:23:24.330353 kernel: ima: Allocated hash algorithm: sha1 Oct 23 00:23:24.330366 kernel: ima: No architecture policies found Oct 23 00:23:24.330374 kernel: clk: Disabling unused clocks Oct 23 00:23:24.330383 kernel: Freeing unused kernel image (initmem) memory: 16144K Oct 23 00:23:24.330392 kernel: Write protecting the kernel read-only data: 47104k Oct 23 00:23:24.330401 kernel: Freeing unused kernel image (rodata/data gap) memory: 108K Oct 23 00:23:24.330411 kernel: Run /init as init process Oct 23 00:23:24.330420 kernel: with arguments: Oct 23 00:23:24.330432 kernel: /init Oct 23 00:23:24.330440 kernel: with environment: Oct 23 00:23:24.330448 kernel: HOME=/ Oct 23 00:23:24.330457 kernel: TERM=linux Oct 23 00:23:24.330465 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Oct 23 00:23:24.330473 kernel: hv_vmbus: Vmbus version:5.3 Oct 23 00:23:24.330483 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 23 00:23:24.330492 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 23 00:23:24.330507 kernel: PTP clock support registered Oct 23 00:23:24.330515 kernel: hv_utils: Registering HyperV Utility Driver Oct 23 00:23:24.330523 kernel: hv_vmbus: registering driver hv_utils Oct 23 00:23:24.330531 kernel: hv_utils: Shutdown IC version 3.2 Oct 23 00:23:24.330539 kernel: hv_utils: Heartbeat IC version 3.0 Oct 23 00:23:24.330547 kernel: hv_utils: TimeSync IC version 4.0 Oct 23 00:23:24.330555 kernel: SCSI subsystem initialized Oct 23 00:23:24.330566 kernel: hv_vmbus: registering driver hv_pci Oct 23 00:23:24.330758 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI VMBus probing: Using version 0x10004 Oct 23 00:23:24.330910 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI host bridge to bus c05b:00 Oct 23 00:23:24.331078 kernel: pci_bus c05b:00: root bus resource [mem 0xfc0000000-0xfc007ffff window] Oct 23 00:23:24.331228 kernel: pci_bus c05b:00: No busn resource found for root bus, will use [bus 00-ff] Oct 23 00:23:24.331413 kernel: pci c05b:00:00.0: [1414:00a9] type 00 class 0x010802 PCIe Endpoint Oct 23 00:23:24.331574 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit] Oct 23 00:23:24.331714 kernel: pci_bus c05b:00: busn_res: [bus 00-ff] end is updated to 00 Oct 23 00:23:24.331898 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit]: assigned Oct 23 00:23:24.331910 kernel: hv_vmbus: registering driver hv_storvsc Oct 23 00:23:24.332065 kernel: scsi host0: storvsc_host_t Oct 23 00:23:24.332235 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Oct 23 00:23:24.332248 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 23 00:23:24.332258 kernel: hv_vmbus: registering driver hid_hyperv Oct 23 00:23:24.332268 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Oct 23 00:23:24.332404 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Oct 23 00:23:24.332420 kernel: hv_vmbus: registering driver hyperv_keyboard Oct 23 00:23:24.332430 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 Oct 23 00:23:24.332575 kernel: nvme nvme0: pci function c05b:00:00.0 Oct 23 00:23:24.332744 kernel: nvme c05b:00:00.0: enabling device (0000 -> 0002) Oct 23 00:23:24.332877 kernel: nvme nvme0: 2/0/0 default/read/poll queues Oct 23 00:23:24.332890 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 23 00:23:24.333048 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Oct 23 00:23:24.333059 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 23 00:23:24.333233 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Oct 23 00:23:24.333247 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 23 00:23:24.333274 kernel: device-mapper: uevent: version 1.0.3 Oct 23 00:23:24.333288 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 23 00:23:24.333301 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Oct 23 00:23:24.333311 kernel: raid6: avx512x4 gen() 44056 MB/s Oct 23 00:23:24.333322 kernel: raid6: avx512x2 gen() 43054 MB/s Oct 23 00:23:24.333333 kernel: raid6: avx512x1 gen() 26463 MB/s Oct 23 00:23:24.333342 kernel: raid6: avx2x4 gen() 37198 MB/s Oct 23 00:23:24.333351 kernel: raid6: avx2x2 gen() 39820 MB/s Oct 23 00:23:24.333362 kernel: raid6: avx2x1 gen() 31308 MB/s Oct 23 00:23:24.333376 kernel: raid6: using algorithm avx512x4 gen() 44056 MB/s Oct 23 00:23:24.333386 kernel: raid6: .... xor() 7608 MB/s, rmw enabled Oct 23 00:23:24.333395 kernel: raid6: using avx512x2 recovery algorithm Oct 23 00:23:24.333406 kernel: xor: automatically using best checksumming function avx Oct 23 00:23:24.333417 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 23 00:23:24.333428 kernel: BTRFS: device fsid ec2dc77b-74c3-4a95-8fc9-635597c896bb devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (919) Oct 23 00:23:24.333437 kernel: BTRFS info (device dm-0): first mount of filesystem ec2dc77b-74c3-4a95-8fc9-635597c896bb Oct 23 00:23:24.333451 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Oct 23 00:23:24.333460 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Oct 23 00:23:24.333470 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Oct 23 00:23:24.333479 kernel: BTRFS info (device dm-0 state E): enabling free space tree Oct 23 00:23:24.333491 kernel: loop: module loaded Oct 23 00:23:24.333503 kernel: loop0: detected capacity change from 0 to 109736 Oct 23 00:23:24.333512 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 23 00:23:24.333525 systemd[1]: Successfully made /usr/ read-only. Oct 23 00:23:24.333545 systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Oct 23 00:23:24.333557 systemd[1]: Detected virtualization microsoft. Oct 23 00:23:24.333568 systemd[1]: Detected architecture x86-64. Oct 23 00:23:24.333579 systemd[1]: Running in initrd. Oct 23 00:23:24.333590 systemd[1]: Initializing machine ID from random generator. Oct 23 00:23:24.333602 systemd[1]: No hostname configured, using default hostname. Oct 23 00:23:24.333612 systemd[1]: Hostname set to . Oct 23 00:23:24.333622 systemd[1]: Queued start job for default target initrd.target. Oct 23 00:23:24.333632 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 23 00:23:24.333654 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 23 00:23:24.333664 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 23 00:23:24.333678 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 23 00:23:24.333687 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 23 00:23:24.333697 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 23 00:23:24.333706 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 23 00:23:24.333717 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 23 00:23:24.333742 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 23 00:23:24.333751 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 23 00:23:24.333761 systemd[1]: Reached target paths.target - Path Units. Oct 23 00:23:24.333770 systemd[1]: Reached target slices.target - Slice Units. Oct 23 00:23:24.333780 systemd[1]: Reached target swap.target - Swaps. Oct 23 00:23:24.333790 systemd[1]: Reached target timers.target - Timer Units. Oct 23 00:23:24.333802 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 23 00:23:24.333813 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 23 00:23:24.333823 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 23 00:23:24.333833 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 23 00:23:24.333843 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 23 00:23:24.333852 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 23 00:23:24.333864 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 23 00:23:24.333874 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 23 00:23:24.333883 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 23 00:23:24.333894 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 23 00:23:24.333904 systemd[1]: Reached target sockets.target - Socket Units. Oct 23 00:23:24.333914 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 23 00:23:24.333925 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 23 00:23:24.333937 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 23 00:23:24.333946 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 23 00:23:24.333956 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Oct 23 00:23:24.333966 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 23 00:23:24.333975 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 23 00:23:24.333983 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 23 00:23:24.333995 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 23 00:23:24.334032 systemd-journald[1028]: Collecting audit messages is enabled. Oct 23 00:23:24.334057 kernel: audit: type=1130 audit(1792715004.324: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' Oct 23 00:23:24.334067 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 23 00:23:24.334079 systemd-journald[1028]: Journal started Oct 23 00:23:24.334103 systemd-journald[1028]: Runtime Journal (/run/log/journal/27529499b1284bdca5c30b2ab36858cc) is 8M, max 158.5M, 150.5M free. Oct 23 00:23:24.324000 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' Oct 23 00:23:24.322468 systemd-modules-load[1031]: Using 2 probe threads Oct 23 00:23:24.333000 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' Oct 23 00:23:24.340936 kernel: audit: type=1130 audit(1792715004.333: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' Oct 23 00:23:24.341013 systemd[1]: Started systemd-journald.service - Journal Service. Oct 23 00:23:24.343000 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' Oct 23 00:23:24.350042 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 23 00:23:24.353353 kernel: audit: type=1130 audit(1792715004.343:4): 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' Oct 23 00:23:24.357838 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 23 00:23:24.438956 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 23 00:23:24.438009 systemd-tmpfiles[1039]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Oct 23 00:23:24.438076 systemd-tmpfiles[1039]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 23 00:23:24.444062 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 23 00:23:24.443000 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' Oct 23 00:23:24.451108 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 23 00:23:24.452199 kernel: audit: type=1130 audit(1792715004.443:5): 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' Oct 23 00:23:24.450000 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' Oct 23 00:23:24.456741 kernel: audit: type=1130 audit(1792715004.450:6): 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' Oct 23 00:23:24.456885 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 23 00:23:24.468220 systemd-modules-load[1031]: Inserted module 'br_netfilter' Oct 23 00:23:24.468765 kernel: Bridge firewalling registered Oct 23 00:23:24.467000 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' Oct 23 00:23:24.468990 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 23 00:23:24.473745 kernel: audit: type=1130 audit(1792715004.467:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:23:24.475862 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 23 00:23:24.501407 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 23 00:23:24.503000 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' Oct 23 00:23:24.509736 kernel: audit: type=1130 audit(1792715004.503:8): 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' Oct 23 00:23:24.528186 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 23 00:23:24.528429 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 23 00:23:24.526000 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' Oct 23 00:23:24.526000 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' Oct 23 00:23:24.535000 audit: BPF prog-id=5 op=LOAD Oct 23 00:23:24.540470 kernel: audit: type=1130 audit(1792715004.526:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:23:24.537856 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 23 00:23:24.542975 kernel: audit: type=1131 audit(1792715004.526: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' Oct 23 00:23:24.542998 kernel: audit: type=1334 audit(1792715004.535:11): prog-id=5 op=LOAD Oct 23 00:23:24.543174 systemd-vconsole-setup[1034]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 23 00:23:24.551926 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 23 00:23:24.551000 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' Oct 23 00:23:24.555854 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 23 00:23:24.583447 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 23 00:23:24.586000 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' Oct 23 00:23:24.635952 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 23 00:23:24.664716 systemd-resolved[1050]: Positive Trust Anchors: Oct 23 00:23:24.664747 systemd-resolved[1050]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 23 00:23:24.664750 systemd-resolved[1050]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 23 00:23:24.664783 systemd-resolved[1050]: 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 Oct 23 00:23:24.702234 dracut-cmdline[1063]: dracut-110 Oct 23 00:23:24.705003 dracut-cmdline[1063]: 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=b43ade646e91e9e680533d5f7ade45cc03aa19a17b73a6ed41a2e97e5811fd56 Oct 23 00:23:24.833134 systemd-resolved[1050]: Defaulting to hostname 'linux'. Oct 23 00:23:24.834850 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 23 00:23:24.836000 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' Oct 23 00:23:24.838075 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 23 00:23:24.943759 kernel: Loading iSCSI transport class v2.0-870. Oct 23 00:23:25.062745 kernel: iscsi: registered transport (tcp) Oct 23 00:23:25.115226 kernel: iscsi: registered transport (qla4xxx) Oct 23 00:23:25.115271 kernel: QLogic iSCSI HBA Driver Oct 23 00:23:25.162171 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 23 00:23:25.176301 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 23 00:23:25.177000 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' Oct 23 00:23:25.180171 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 23 00:23:25.215328 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 23 00:23:25.217000 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' Oct 23 00:23:25.219560 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 23 00:23:25.229890 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 23 00:23:25.254048 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 23 00:23:25.254000 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' Oct 23 00:23:25.254000 audit: BPF prog-id=6 op=LOAD Oct 23 00:23:25.255000 audit: BPF prog-id=7 op=LOAD Oct 23 00:23:25.258346 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 23 00:23:25.319831 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 23 00:23:25.322000 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' Oct 23 00:23:25.524997 systemd-udevd[1295]: Using default interface naming scheme 'v260'. Oct 23 00:23:25.560000 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' Oct 23 00:23:25.559356 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 23 00:23:25.563135 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 23 00:23:25.571000 audit: BPF prog-id=8 op=LOAD Oct 23 00:23:25.574673 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 23 00:23:25.592436 dracut-pre-trigger[1400]: rd.md=0: removing MD RAID activation Oct 23 00:23:25.618903 systemd-networkd[1414]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Oct 23 00:23:25.624914 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 23 00:23:25.627673 systemd-networkd[1414]: lo: Link UP Oct 23 00:23:25.627895 systemd-networkd[1414]: lo: Gained carrier Oct 23 00:23:25.631000 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' Oct 23 00:23:25.632915 systemd[1]: Started systemd-networkd.service - Network Management. Oct 23 00:23:25.635000 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' Oct 23 00:23:25.637236 systemd[1]: Reached target network.target - Network. Oct 23 00:23:25.639585 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 23 00:23:25.704919 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 23 00:23:25.705000 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' Oct 23 00:23:25.711873 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 23 00:23:25.837772 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 23 00:23:25.840020 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 23 00:23:25.842000 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' Oct 23 00:23:25.843417 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 23 00:23:25.849450 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 23 00:23:25.870766 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#38 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 23 00:23:25.875753 kernel: hv_vmbus: registering driver hv_netvsc Oct 23 00:23:25.883240 kernel: hv_netvsc f8615163-0000-1000-2000-0022489e1d76 (unnamed net_device) (uninitialized): VF slot 1 added Oct 23 00:23:25.913407 systemd-networkd[1414]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 23 00:23:25.913418 systemd-networkd[1414]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 23 00:23:25.916013 systemd-networkd[1414]: eth0: Link UP Oct 23 00:23:25.916967 systemd-networkd[1414]: eth0: Gained carrier Oct 23 00:23:25.916980 systemd-networkd[1414]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 23 00:23:25.926645 kernel: cryptd: max_cpu_qlen set to 1000 Oct 23 00:23:25.928553 systemd-vconsole-setup[1486]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 23 00:23:25.929000 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' Oct 23 00:23:25.930336 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 23 00:23:25.936867 systemd-networkd[1414]: eth0: DHCPv4 address 10.0.0.27/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 23 00:23:25.978758 kernel: AES CTR mode by8 optimization enabled Oct 23 00:23:26.340746 kernel: nvme nvme0: using unchecked data buffer Oct 23 00:23:26.896354 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 Oct 23 00:23:26.896630 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 Oct 23 00:23:26.900193 kernel: pci_bus 7870:00: root bus resource [mem 0xfc2000000-0xfc4007fff window] Oct 23 00:23:26.901533 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] Oct 23 00:23:26.906784 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint Oct 23 00:23:26.909732 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref] Oct 23 00:23:26.913855 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref] Oct 23 00:23:26.915803 kernel: pci 7870:00:00.0: enabling Extended Tags Oct 23 00:23:26.927957 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 Oct 23 00:23:26.928189 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref]: assigned Oct 23 00:23:26.931776 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref]: assigned Oct 23 00:23:27.025252 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) Oct 23 00:23:27.032735 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 Oct 23 00:23:27.036457 kernel: hv_netvsc f8615163-0000-1000-2000-0022489e1d76 eth0: VF registering: eth1 Oct 23 00:23:27.036610 kernel: mana 7870:00:00.0 eth1: joined to eth0 Oct 23 00:23:27.041778 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 Oct 23 00:23:27.041951 systemd-networkd[1414]: eth1: Interface name change detected, renamed to enP30832s1. Oct 23 00:23:27.140739 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Oct 23 00:23:27.142814 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Oct 23 00:23:27.143427 kernel: hv_netvsc f8615163-0000-1000-2000-0022489e1d76 eth0: Data path switched to VF: enP30832s1 Oct 23 00:23:27.144349 systemd-networkd[1414]: enP30832s1: Link UP Oct 23 00:23:27.144489 systemd-networkd[1414]: enP30832s1: Gained carrier Oct 23 00:23:27.521008 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - MSFT NVMe Accelerator v1.0 EFI-SYSTEM. Oct 23 00:23:27.538317 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - MSFT NVMe Accelerator v1.0 ROOT. Oct 23 00:23:27.566712 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - MSFT NVMe Accelerator v1.0 USR-A. Oct 23 00:23:27.570607 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 23 00:23:27.608704 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Oct 23 00:23:27.667941 systemd[1]: Mounting oem.mount - /oem... Oct 23 00:23:27.671563 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 23 00:23:27.673000 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' Oct 23 00:23:27.675020 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 23 00:23:27.675537 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 23 00:23:27.675567 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 23 00:23:27.734455 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 23 00:23:27.739664 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1617) Oct 23 00:23:27.756775 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 4f26f92a-4f97-4d1c-8efa-a00fa1220b67 Oct 23 00:23:27.759775 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Oct 23 00:23:27.792134 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 23 00:23:27.793000 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' Oct 23 00:23:27.921965 systemd-networkd[1414]: eth0: Gained IPv6LL Oct 23 00:23:28.029375 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 23 00:23:28.029437 kernel: BTRFS info (device nvme0n1p6): turning on async discard Oct 23 00:23:28.031206 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 23 00:23:28.032612 systemd[1]: Mounted oem.mount - /oem. Oct 23 00:23:28.035020 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 23 00:23:29.034846 disk-uuid[1611]: Warning: The kernel is still using the old partition table. Oct 23 00:23:29.034846 disk-uuid[1611]: The new table will be used at the next reboot or after you Oct 23 00:23:29.034846 disk-uuid[1611]: run partprobe(8) or kpartx(8) Oct 23 00:23:29.034846 disk-uuid[1611]: The operation has completed successfully. Oct 23 00:23:30.421514 ignition[1645]: Ignition 2.24.0 Oct 23 00:23:30.421527 ignition[1645]: Stage: fetch-offline Oct 23 00:23:30.421797 ignition[1645]: no config dir at "/usr/lib/ignition/base.d" Oct 23 00:23:30.421806 ignition[1645]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 23 00:23:30.422759 ignition[1645]: parsed url from cmdline: "" Oct 23 00:23:30.429142 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 23 00:23:30.422764 ignition[1645]: no config URL provided Oct 23 00:23:30.422771 ignition[1645]: reading system config file "/usr/lib/ignition/user.ign" Oct 23 00:23:30.422803 ignition[1645]: no config at "/usr/lib/ignition/user.ign" Oct 23 00:23:30.422809 ignition[1645]: failed to fetch config: resource requires networking Oct 23 00:23:30.425971 ignition[1645]: Ignition finished successfully Oct 23 00:23:30.438000 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' Oct 23 00:23:30.441827 kernel: kauditd_printk_skb: 18 callbacks suppressed Oct 23 00:23:30.441861 kernel: audit: type=1130 audit(1792715010.438:30): 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' Oct 23 00:23:30.445941 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 23 00:23:30.483530 ignition[1669]: Ignition 2.24.0 Oct 23 00:23:30.483543 ignition[1669]: Stage: fetch Oct 23 00:23:30.483770 ignition[1669]: no config dir at "/usr/lib/ignition/base.d" Oct 23 00:23:30.483777 ignition[1669]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 23 00:23:30.486092 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 23 00:23:30.485572 ignition[1669]: parsed url from cmdline: "" Oct 23 00:23:30.486192 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 23 00:23:30.489000 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' Oct 23 00:23:30.489000 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' Oct 23 00:23:30.485576 ignition[1669]: no config URL provided Oct 23 00:23:30.504167 kernel: audit: type=1130 audit(1792715010.489:31): 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' Oct 23 00:23:30.492363 systemd[1]: Mounting boot.mount - Boot partition... Oct 23 00:23:30.485582 ignition[1669]: reading system config file "/usr/lib/ignition/user.ign" Oct 23 00:23:30.507898 kernel: audit: type=1131 audit(1792715010.489:32): 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' Oct 23 00:23:30.485593 ignition[1669]: no config at "/usr/lib/ignition/user.ign" Oct 23 00:23:30.485612 ignition[1669]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Oct 23 00:23:30.550240 ignition[1669]: GET result: OK Oct 23 00:23:30.550318 ignition[1669]: config has been read from IMDS userdata Oct 23 00:23:30.550329 ignition[1669]: parsing config with SHA512: fbcaa7b41242850f81d373e6e588e117ff92ec93e21686626e2d1918ed87b7773c670dbdf4781662849674ff33e1cf8501b8541bd4e2d679c23c7cea5ca52dfd Oct 23 00:23:30.569505 unknown[1669]: fetched base config from "system" Oct 23 00:23:30.569529 unknown[1669]: fetched base config from "system" Oct 23 00:23:30.569685 ignition[1669]: fetch: fetch complete Oct 23 00:23:30.569535 unknown[1669]: fetched user config from "azure" Oct 23 00:23:30.569689 ignition[1669]: fetch: fetch passed Oct 23 00:23:30.572744 systemd[1]: Mounted boot.mount - Boot partition. Oct 23 00:23:30.569739 ignition[1669]: Ignition finished successfully Oct 23 00:23:30.575276 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 23 00:23:30.581000 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' Oct 23 00:23:30.584871 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 23 00:23:30.588363 kernel: audit: type=1130 audit(1792715010.581:33): 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' Oct 23 00:23:30.602195 ignition[1685]: Ignition 2.24.0 Oct 23 00:23:30.602205 ignition[1685]: Stage: kargs Oct 23 00:23:30.604000 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' Oct 23 00:23:30.604571 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 23 00:23:30.602398 ignition[1685]: no config dir at "/usr/lib/ignition/base.d" Oct 23 00:23:30.612902 kernel: audit: type=1130 audit(1792715010.604:34): 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' Oct 23 00:23:30.612841 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 23 00:23:30.602405 ignition[1685]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 23 00:23:30.603192 ignition[1685]: kargs: kargs passed Oct 23 00:23:30.603229 ignition[1685]: Ignition finished successfully Oct 23 00:23:30.679778 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 23 00:23:30.679886 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 23 00:23:30.682000 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' Oct 23 00:23:30.684017 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 23 00:23:30.687000 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' Oct 23 00:23:30.687584 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 23 00:23:30.688000 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' Oct 23 00:23:30.700992 kernel: audit: type=1131 audit(1792715010.682:35): 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' Oct 23 00:23:30.688682 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 23 00:23:30.703813 kernel: audit: type=1131 audit(1792715010.687:36): 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' Oct 23 00:23:30.688821 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 23 00:23:30.706803 kernel: audit: type=1131 audit(1792715010.688:37): 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' Oct 23 00:23:30.689344 systemd[1]: Unmounting oem.mount - /oem... Oct 23 00:23:30.710350 systemd[1]: oem.mount: Deactivated successfully. Oct 23 00:23:30.713163 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 4f26f92a-4f97-4d1c-8efa-a00fa1220b67 Oct 23 00:23:30.710469 systemd[1]: Unmounted oem.mount - /oem. Oct 23 00:23:30.734012 ignition[1695]: Ignition 2.24.0 Oct 23 00:23:30.734025 ignition[1695]: Stage: disks Oct 23 00:23:30.734000 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' Oct 23 00:23:30.734232 ignition[1695]: no config dir at "/usr/lib/ignition/base.d" Oct 23 00:23:30.735804 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 23 00:23:30.753287 kernel: audit: type=1130 audit(1792715010.734:38): 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' Oct 23 00:23:30.734238 ignition[1695]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 23 00:23:30.736968 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 23 00:23:30.734769 ignition[1695]: disks: disks passed Oct 23 00:23:30.737029 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 23 00:23:30.734802 ignition[1695]: Ignition finished successfully Oct 23 00:23:30.737066 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 23 00:23:30.737344 systemd[1]: Reached target sysinit.target - System Initialization. Oct 23 00:23:30.750054 systemd[1]: Reached target basic.target - Basic System. Oct 23 00:23:30.762417 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 23 00:23:31.231258 systemd-fsck[1705]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Oct 23 00:23:31.236289 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 23 00:23:31.236000 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' Oct 23 00:23:31.243209 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 23 00:23:31.247287 kernel: audit: type=1130 audit(1792715011.236:39): 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' Oct 23 00:23:31.641776 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 6a0ed0ca-a1b4-4497-8982-1ce91505e576 r/w with ordered data mode. Quota mode: none. Oct 23 00:23:31.642992 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 23 00:23:31.645445 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 23 00:23:31.667521 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 23 00:23:31.670798 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Oct 23 00:23:31.677137 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Oct 23 00:23:31.677177 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 23 00:23:31.688310 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 23 00:23:31.691594 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 23 00:23:33.136095 systemd-tmpfiles[1734]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:1: Duplicate line for path "/sysroot/var", ignoring. Oct 23 00:23:33.136135 systemd-tmpfiles[1734]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:7: Duplicate line for path "/sysroot/var/empty", ignoring. Oct 23 00:23:33.136238 systemd-tmpfiles[1734]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:28: Duplicate line for path "/sysroot/var/log", ignoring. Oct 23 00:23:33.810212 coreos-metadata[1715]: Oct 23 00:23:33.809 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Oct 23 00:23:33.814160 coreos-metadata[1715]: Oct 23 00:23:33.814 INFO Fetch successful Oct 23 00:23:33.815667 coreos-metadata[1715]: Oct 23 00:23:33.815 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Oct 23 00:23:33.823057 coreos-metadata[1715]: Oct 23 00:23:33.823 INFO Fetch successful Oct 23 00:23:33.823057 coreos-metadata[1715]: Oct 23 00:23:33.823 INFO wrote hostname ci-4757.2.1-n-fba02c1b66 to /sysroot/etc/hostname Oct 23 00:23:33.826047 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 23 00:23:33.827000 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' Oct 23 00:23:34.913840 kernel: loop1: detected capacity change from 0 to 44360 Oct 23 00:23:34.955739 kernel: loop1: p1 p2 p3 Oct 23 00:23:35.669738 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:35.669847 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:35.671364 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:35.672927 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:35.672970 systemd-confext[1796]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Oct 23 00:23:35.737745 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:35.809779 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 23 00:23:35.831742 kernel: loop2: detected capacity change from 0 to 44360 Oct 23 00:23:35.839935 kernel: loop2: p1 p2 p3 Oct 23 00:23:35.850602 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:35.850686 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:35.850836 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:35.853150 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:35.853237 (sd-merge)[1810]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Oct 23 00:23:35.857839 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:35.874446 (sd-merge)[1810]: Using extensions '00-flatcar-default.raw'. Oct 23 00:23:35.875313 (sd-merge)[1810]: Merged extensions into '/sysroot/etc'. Oct 23 00:23:35.878819 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 23 00:23:35.880849 initrd-setup-root[1818]: /etc 00-flatcar-default Fri 2026-10-23 00:23:24 UTC Oct 23 00:23:35.883193 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 23 00:23:35.883000 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' Oct 23 00:23:35.889480 kernel: kauditd_printk_skb: 1 callbacks suppressed Oct 23 00:23:35.889506 kernel: audit: type=1130 audit(1792715015.883: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' Oct 23 00:23:35.889627 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 23 00:23:35.935219 ignition[1822]: INFO : Ignition 2.24.0 Oct 23 00:23:35.935219 ignition[1822]: INFO : Stage: mount Oct 23 00:23:35.939071 ignition[1822]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 23 00:23:35.939071 ignition[1822]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 23 00:23:35.939071 ignition[1822]: INFO : mount: mount passed Oct 23 00:23:35.939071 ignition[1822]: INFO : Ignition finished successfully Oct 23 00:23:35.943000 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' Oct 23 00:23:35.937069 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 23 00:23:35.951695 kernel: audit: type=1130 audit(1792715015.943:42): 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' Oct 23 00:23:35.948665 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 23 00:23:35.966992 systemd[1]: Mounting oem.mount - /oem... Oct 23 00:23:35.979736 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1830) Oct 23 00:23:35.981766 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 4f26f92a-4f97-4d1c-8efa-a00fa1220b67 Oct 23 00:23:35.981848 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Oct 23 00:23:35.989067 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 23 00:23:35.989104 kernel: BTRFS info (device nvme0n1p6): turning on async discard Oct 23 00:23:35.990353 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 23 00:23:35.992671 systemd[1]: Mounted oem.mount - /oem. Oct 23 00:23:35.994308 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 23 00:23:36.017355 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 23 00:23:36.037939 ignition[1847]: INFO : Ignition 2.24.0 Oct 23 00:23:36.037939 ignition[1847]: INFO : Stage: files Oct 23 00:23:36.040954 ignition[1847]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 23 00:23:36.040954 ignition[1847]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 23 00:23:36.040954 ignition[1847]: DEBUG : files: compiled without relabeling support, skipping Oct 23 00:23:36.040954 ignition[1847]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 23 00:23:36.040954 ignition[1847]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 23 00:23:36.049000 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' Oct 23 00:23:36.054919 ignition[1847]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 23 00:23:36.054919 ignition[1847]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 23 00:23:36.054919 ignition[1847]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 23 00:23:36.054919 ignition[1847]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 23 00:23:36.054919 ignition[1847]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 23 00:23:36.054919 ignition[1847]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 23 00:23:36.054919 ignition[1847]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 23 00:23:36.054919 ignition[1847]: INFO : files: files passed Oct 23 00:23:36.054919 ignition[1847]: INFO : Ignition finished successfully Oct 23 00:23:36.044270 unknown[1847]: wrote ssh authorized keys file for user: core Oct 23 00:23:36.055766 kernel: audit: type=1130 audit(1792715016.049:43): 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' Oct 23 00:23:36.045923 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 23 00:23:36.053928 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 23 00:23:36.075835 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 23 00:23:36.083434 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 23 00:23:36.083915 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 23 00:23:36.088000 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' Oct 23 00:23:36.088000 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' Oct 23 00:23:36.096029 kernel: audit: type=1130 audit(1792715016.088:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:23:36.096050 kernel: audit: type=1131 audit(1792715016.088: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' Oct 23 00:23:36.113033 initrd-setup-root-after-ignition[1881]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 23 00:23:36.113033 initrd-setup-root-after-ignition[1881]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 23 00:23:36.119050 initrd-setup-root-after-ignition[1885]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 23 00:23:36.122282 kernel: loop3: detected capacity change from 0 to 44360 Oct 23 00:23:36.133772 kernel: loop3: p1 p2 p3 Oct 23 00:23:36.143376 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:36.143419 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:36.144778 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:36.145825 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:36.146244 systemd-confext[1887]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Oct 23 00:23:36.154740 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:36.174739 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 23 00:23:36.198750 kernel: loop4: detected capacity change from 0 to 44360 Oct 23 00:23:36.206862 kernel: loop4: p1 p2 p3 Oct 23 00:23:36.213131 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:36.213175 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:36.214521 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:36.215970 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:36.216472 (sd-merge)[1895]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Oct 23 00:23:36.223878 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:36.238408 (sd-merge)[1895]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 23 00:23:36.240526 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 23 00:23:36.327749 kernel: loop4: detected capacity change from 0 to 388528 Oct 23 00:23:36.432740 kernel: loop4: p1 p2 p3 Oct 23 00:23:36.858790 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:36.858860 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:36.860277 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:36.861606 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:36.862118 systemd-sysext[1903]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Oct 23 00:23:36.866737 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:37.258773 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 23 00:23:37.428760 kernel: loop5: detected capacity change from 0 to 137048 Oct 23 00:23:37.509817 kernel: loop5: p1 p2 p3 Oct 23 00:23:37.784198 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:37.784260 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:37.785399 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:37.786752 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:37.787053 systemd-sysext[1903]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Oct 23 00:23:37.791055 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:38.041770 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 23 00:23:38.089766 kernel: loop6: detected capacity change from 0 to 183832 Oct 23 00:23:38.139791 kernel: loop6: p1 p2 p3 Oct 23 00:23:38.535860 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:38.535919 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:38.536966 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:38.537950 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:38.538315 systemd-sysext[1903]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Oct 23 00:23:38.542739 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:38.736779 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 23 00:23:38.756738 kernel: loop7: detected capacity change from 0 to 388528 Oct 23 00:23:38.764742 kernel: loop7: p1 p2 p3 Oct 23 00:23:38.772303 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:38.772340 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:38.774214 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:38.777273 (sd-merge)[1927]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Oct 23 00:23:38.780078 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:38.782756 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:38.842758 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 23 00:23:38.845797 kernel: loop1: detected capacity change from 0 to 137048 Oct 23 00:23:38.850740 kernel: loop1: p1 p2 p3 Oct 23 00:23:38.858494 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:38.858538 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:38.860700 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:38.860757 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:38.860898 (sd-merge)[1927]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Oct 23 00:23:38.866753 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:38.903746 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Oct 23 00:23:38.906747 kernel: loop3: detected capacity change from 0 to 183832 Oct 23 00:23:38.915757 kernel: loop3: p1 p2 p3 Oct 23 00:23:38.922380 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:38.922418 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:38.923781 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:38.924837 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:38.924885 (sd-merge)[1927]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Oct 23 00:23:38.927824 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:38.959581 (sd-merge)[1927]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4757.2.1+nightly-20261022-2100.raw'. Oct 23 00:23:38.962610 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Oct 23 00:23:38.960917 (sd-merge)[1927]: Merged extensions into '/sysroot/usr'. Oct 23 00:23:38.965715 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 23 00:23:38.968000 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' Oct 23 00:23:38.971958 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 23 00:23:38.977822 kernel: audit: type=1130 audit(1792715018.968:46): 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' Oct 23 00:23:38.986684 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 23 00:23:38.987323 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 23 00:23:38.991000 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' Oct 23 00:23:38.992440 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Oct 23 00:23:38.991000 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' Oct 23 00:23:39.004431 kernel: audit: type=1130 audit(1792715018.991:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:23:38.992866 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 23 00:23:39.005214 kernel: audit: type=1131 audit(1792715018.991: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' Oct 23 00:23:39.004856 systemd[1]: Starting dracut-mount.service - dracut mount hook... Oct 23 00:23:39.432315 systemd[1]: Finished dracut-mount.service - dracut mount hook. Oct 23 00:23:39.435000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:23:39.438414 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 23 00:23:39.442918 kernel: audit: type=1130 audit(1792715019.435:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:23:39.461198 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 23 00:23:39.462681 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 23 00:23:39.459000 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' Oct 23 00:23:39.472754 kernel: audit: type=1130 audit(1792715019.459: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' Oct 23 00:23:39.482108 systemd[1]: Stopped target basic.target - Basic System. Oct 23 00:23:39.485854 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 23 00:23:39.489851 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 23 00:23:39.493841 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 23 00:23:39.493984 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 23 00:23:39.494206 systemd[1]: Stopped target paths.target - Path Units. Oct 23 00:23:39.494487 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 23 00:23:39.494781 systemd[1]: Stopped target slices.target - Slice Units. Oct 23 00:23:39.513000 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' Oct 23 00:23:39.495040 systemd[1]: Stopped target sockets.target - Socket Units. Oct 23 00:23:39.495274 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 23 00:23:39.496180 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 23 00:23:39.496419 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Oct 23 00:23:39.508141 systemd[1]: Stopped target swap.target - Swaps. Oct 23 00:23:39.530000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:23:39.512875 systemd[1]: Stopped target timers.target - Timer Units. Oct 23 00:23:39.532000 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' Oct 23 00:23:39.513312 systemd[1]: iscsid.socket: Deactivated successfully. Oct 23 00:23:39.513412 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 23 00:23:39.513672 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 23 00:23:39.513767 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 23 00:23:39.514019 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 23 00:23:39.514095 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Oct 23 00:23:39.514358 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Oct 23 00:23:39.514429 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Oct 23 00:23:39.514760 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 23 00:23:39.559000 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' Oct 23 00:23:39.560000 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' Oct 23 00:23:39.562000 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' Oct 23 00:23:39.562000 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' Oct 23 00:23:39.563000 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' Oct 23 00:23:39.565000 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' Oct 23 00:23:39.514872 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 23 00:23:39.515132 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 23 00:23:39.515407 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 23 00:23:39.515591 systemd[1]: dracut-mount.service: Deactivated successfully. Oct 23 00:23:39.576000 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' Oct 23 00:23:39.578000 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' Oct 23 00:23:39.515672 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Oct 23 00:23:39.530977 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 23 00:23:39.592000 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' Oct 23 00:23:39.592000 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' Oct 23 00:23:39.531063 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 23 00:23:39.534809 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 23 00:23:39.599000 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' Oct 23 00:23:39.602841 ignition[1969]: INFO : Ignition 2.24.0 Oct 23 00:23:39.602841 ignition[1969]: INFO : Stage: umount Oct 23 00:23:39.602841 ignition[1969]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 23 00:23:39.602841 ignition[1969]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 23 00:23:39.602841 ignition[1969]: INFO : umount: umount passed Oct 23 00:23:39.602841 ignition[1969]: INFO : Ignition finished successfully Oct 23 00:23:39.540340 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 23 00:23:39.540549 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 23 00:23:39.547200 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 23 00:23:39.551544 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 23 00:23:39.551785 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 23 00:23:39.556111 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 23 00:23:39.556220 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 23 00:23:39.560970 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 23 00:23:39.561089 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 23 00:23:39.562358 systemd[1]: ignition-files.service: Deactivated successfully. Oct 23 00:23:39.562456 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 23 00:23:39.562945 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Oct 23 00:23:39.563039 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 23 00:23:39.564832 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 23 00:23:39.564907 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 23 00:23:39.565028 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 23 00:23:39.565278 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 23 00:23:39.565378 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 23 00:23:39.565818 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 23 00:23:39.565915 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 23 00:23:39.577541 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 23 00:23:39.577662 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 23 00:23:39.583071 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 23 00:23:39.583166 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 23 00:23:39.598320 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 23 00:23:39.598424 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 23 00:23:39.601502 systemd[1]: Stopped target network.target - Network. Oct 23 00:23:39.640786 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 23 00:23:39.640834 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 23 00:23:39.643000 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' Oct 23 00:23:39.644381 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 23 00:23:39.645000 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' Oct 23 00:23:39.644406 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 23 00:23:39.649000 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' Oct 23 00:23:39.648255 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 23 00:23:39.648287 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 23 00:23:39.650846 systemd[1]: Stopping systemd-networkd.service - Network Management... Oct 23 00:23:39.654630 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 23 00:23:39.659000 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' Oct 23 00:23:39.660980 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 23 00:23:39.661096 systemd[1]: Stopped systemd-networkd.service - Network Management. Oct 23 00:23:39.664000 audit: BPF prog-id=8 op=UNLOAD Oct 23 00:23:39.665360 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Oct 23 00:23:39.665399 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 23 00:23:39.669888 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 23 00:23:39.679000 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' Oct 23 00:23:39.672348 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 23 00:23:39.672384 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Oct 23 00:23:39.674822 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 23 00:23:39.678806 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 23 00:23:39.678853 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 23 00:23:39.681249 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 23 00:23:39.695039 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 23 00:23:39.696979 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 23 00:23:39.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' Oct 23 00:23:39.699000 audit: BPF prog-id=5 op=UNLOAD Oct 23 00:23:39.736551 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 23 00:23:39.736691 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 23 00:23:39.740000 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' Oct 23 00:23:39.741823 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 23 00:23:39.741875 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 23 00:23:39.747000 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' Oct 23 00:23:39.746845 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 23 00:23:39.746889 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 23 00:23:39.752000 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' Oct 23 00:23:39.749521 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 23 00:23:39.749551 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 23 00:23:39.753993 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 23 00:23:39.754026 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 23 00:23:39.763587 kernel: hv_netvsc f8615163-0000-1000-2000-0022489e1d76 eth0: Data path switched from VF: enP30832s1 Oct 23 00:23:39.763862 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Oct 23 00:23:39.763000 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' Oct 23 00:23:39.766303 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 23 00:23:39.771842 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 23 00:23:39.771884 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 23 00:23:39.774000 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' Oct 23 00:23:39.776000 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' Oct 23 00:23:39.775812 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 23 00:23:39.781000 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' Oct 23 00:23:39.775851 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 23 00:23:39.780568 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 23 00:23:39.788000 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' Oct 23 00:23:39.780611 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 23 00:23:39.784243 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 23 00:23:39.794000 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' Oct 23 00:23:39.784973 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 23 00:23:39.791555 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 23 00:23:39.800000 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' Oct 23 00:23:39.791624 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 23 00:23:39.799077 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 23 00:23:39.799159 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 23 00:23:39.801949 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 23 00:23:39.802037 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 23 00:23:39.810000 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' Oct 23 00:23:39.810000 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' Oct 23 00:23:39.812965 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 23 00:23:39.816374 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 23 00:23:39.837336 systemd[1]: Switching root. Oct 23 00:23:39.894672 systemd-journald[1028]: Journal stopped Oct 23 00:23:47.152830 systemd-journald[1028]: Received SIGTERM from PID 1 (systemd). Oct 23 00:23:47.152854 kernel: SELinux: policy capability network_peer_controls=1 Oct 23 00:23:47.152862 kernel: SELinux: policy capability open_perms=1 Oct 23 00:23:47.152869 kernel: SELinux: policy capability extended_socket_class=1 Oct 23 00:23:47.152876 kernel: SELinux: policy capability always_check_network=0 Oct 23 00:23:47.152882 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 23 00:23:47.152889 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 23 00:23:47.152895 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 23 00:23:47.152901 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 23 00:23:47.152907 kernel: SELinux: policy capability userspace_initial_context=0 Oct 23 00:23:47.152916 systemd[1]: Successfully loaded SELinux policy in 170.188ms. Oct 23 00:23:47.152923 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.725ms. Oct 23 00:23:47.152931 systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Oct 23 00:23:47.152938 systemd[1]: Detected virtualization microsoft. Oct 23 00:23:47.152947 systemd[1]: Detected architecture x86-64. Oct 23 00:23:47.152953 systemd[1]: Detected first boot. Oct 23 00:23:47.152960 systemd[1]: Initializing machine ID from random generator. Oct 23 00:23:47.152967 systemd[1]: Hostname set to . Oct 23 00:23:47.152973 kernel: kauditd_printk_skb: 36 callbacks suppressed Oct 23 00:23:47.152982 kernel: audit: type=1334 audit(1792715022.729:87): prog-id=9 op=LOAD Oct 23 00:23:47.152988 kernel: audit: type=1334 audit(1792715022.729:88): prog-id=9 op=UNLOAD Oct 23 00:23:47.152995 zram_generator::config[2010]: No configuration found. Oct 23 00:23:47.153002 kernel: Guest personality initialized and is inactive Oct 23 00:23:47.153008 kernel: VMCI host device registered (name=vmci, major=10, minor=259) Oct 23 00:23:47.153014 kernel: Initialized host personality Oct 23 00:23:47.153022 kernel: NET: Registered PF_VSOCK protocol family Oct 23 00:23:47.153028 systemd[1]: Applying preset policy. Oct 23 00:23:47.153036 systemd[1]: Created symlink '/etc/systemd/system/timers.target.wants/google-oslogin-cache.timer' → '/usr/lib/systemd/system/google-oslogin-cache.timer'. Oct 23 00:23:47.153044 systemd[1]: Populated /etc with preset unit settings. Oct 23 00:23:47.153051 kernel: audit: type=1334 audit(1792715026.362:89): prog-id=10 op=LOAD Oct 23 00:23:47.153057 kernel: audit: type=1334 audit(1792715026.362:90): prog-id=2 op=UNLOAD Oct 23 00:23:47.153063 kernel: audit: type=1334 audit(1792715026.362:91): prog-id=11 op=LOAD Oct 23 00:23:47.153071 kernel: audit: type=1334 audit(1792715026.362:92): prog-id=12 op=LOAD Oct 23 00:23:47.153077 kernel: audit: type=1334 audit(1792715026.362:93): prog-id=3 op=UNLOAD Oct 23 00:23:47.153085 kernel: audit: type=1334 audit(1792715026.362:94): prog-id=4 op=UNLOAD Oct 23 00:23:47.153091 kernel: audit: type=1334 audit(1792715026.371:95): prog-id=10 op=UNLOAD Oct 23 00:23:47.153098 kernel: audit: type=1131 audit(1792715026.455:96): 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' Oct 23 00:23:47.153104 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 23 00:23:47.153112 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 23 00:23:47.153120 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 23 00:23:47.153129 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 23 00:23:47.153136 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 23 00:23:47.153143 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 23 00:23:47.153150 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 23 00:23:47.153158 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 23 00:23:47.153165 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 23 00:23:47.153172 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 23 00:23:47.153179 systemd[1]: Created slice user.slice - User and Session Slice. Oct 23 00:23:47.153186 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 23 00:23:47.153193 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 23 00:23:47.153200 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 23 00:23:47.153208 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 23 00:23:47.153216 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 23 00:23:47.153223 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 23 00:23:47.153230 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Oct 23 00:23:47.153237 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 23 00:23:47.153244 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 23 00:23:47.153252 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 23 00:23:47.153259 systemd[1]: Reached target imports.target - Image Downloads. Oct 23 00:23:47.153266 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 23 00:23:47.153273 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 23 00:23:47.153280 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 23 00:23:47.153287 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 23 00:23:47.153295 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 23 00:23:47.153302 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 23 00:23:47.153309 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Oct 23 00:23:47.153316 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Oct 23 00:23:47.153325 systemd[1]: Reached target slices.target - Slice Units. Oct 23 00:23:47.153331 systemd[1]: Reached target swap.target - Swaps. Oct 23 00:23:47.153338 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 23 00:23:47.153345 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 23 00:23:47.153352 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 23 00:23:47.153359 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 23 00:23:47.153366 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Oct 23 00:23:47.153374 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 23 00:23:47.153381 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Oct 23 00:23:47.153389 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Oct 23 00:23:47.153396 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Oct 23 00:23:47.153404 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Oct 23 00:23:47.153411 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 23 00:23:47.153419 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Oct 23 00:23:47.153427 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Oct 23 00:23:47.153434 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Oct 23 00:23:47.153441 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Oct 23 00:23:47.153448 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Oct 23 00:23:47.153455 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 23 00:23:47.153462 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 23 00:23:47.153470 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 23 00:23:47.153477 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 23 00:23:47.153484 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 23 00:23:47.153491 systemd[1]: Mounting media.mount - External Media Directory... Oct 23 00:23:47.153498 systemd[1]: proc-xen.mount - /proc/xen skipped, unmet condition check ConditionVirtualization=xen Oct 23 00:23:47.153505 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 23 00:23:47.153512 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 23 00:23:47.153520 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Oct 23 00:23:47.153527 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 23 00:23:47.153534 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 23 00:23:47.153543 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Oct 23 00:23:47.153550 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 23 00:23:47.153557 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 23 00:23:47.153564 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Oct 23 00:23:47.153573 systemd[1]: modprobe@efi_pstore.service - Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore Oct 23 00:23:47.153580 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 23 00:23:47.153587 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Oct 23 00:23:47.153594 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 23 00:23:47.153601 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 23 00:23:47.153608 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 Oct 23 00:23:47.153616 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 23 00:23:47.153623 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 23 00:23:47.153630 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 23 00:23:47.153637 systemd[1]: Reached target time-set.target - System Time Set. Oct 23 00:23:47.153644 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 23 00:23:47.153651 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 23 00:23:47.153658 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 23 00:23:47.153667 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer skipped, unmet condition check ConditionVirtualization=xen Oct 23 00:23:47.153674 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 23 00:23:47.153680 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 23 00:23:47.153687 systemd[1]: Mounted media.mount - External Media Directory. Oct 23 00:23:47.153700 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 23 00:23:47.153708 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 23 00:23:47.153715 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 23 00:23:47.153754 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 23 00:23:47.153764 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 23 00:23:47.153771 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 23 00:23:47.153778 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 23 00:23:47.153785 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 23 00:23:47.153803 systemd-journald[2086]: Collecting audit messages is enabled. Oct 23 00:23:47.153822 systemd-journald[2086]: Journal started Oct 23 00:23:47.153840 systemd-journald[2086]: Runtime Journal (/run/log/journal/2fe99fd3d48e4975a23b0b66b5d61f86) is 8M, max 158.5M, 150.5M free. Oct 23 00:23:46.609000 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 Oct 23 00:23:46.903000 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' Oct 23 00:23:46.906000 audit: BPF prog-id=12 op=UNLOAD Oct 23 00:23:46.906000 audit: BPF prog-id=11 op=UNLOAD Oct 23 00:23:46.906000 audit: BPF prog-id=13 op=LOAD Oct 23 00:23:46.906000 audit: BPF prog-id=14 op=LOAD Oct 23 00:23:46.906000 audit: BPF prog-id=15 op=LOAD Oct 23 00:23:47.033000 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' Oct 23 00:23:47.091000 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' Oct 23 00:23:47.149000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 23 00:23:47.149000 audit[2086]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=3 a1=7ffc1b7b7020 a2=4000 a3=0 items=0 ppid=1 pid=2086 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) Oct 23 00:23:47.149000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 23 00:23:46.356023 systemd[1]: Queued start job for default target multi-user.target. Oct 23 00:23:46.365121 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Oct 23 00:23:46.366191 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 23 00:23:47.156780 systemd[1]: Started systemd-journald.service - Journal Service. Oct 23 00:23:47.159000 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' Oct 23 00:23:47.176416 systemd-modules-load[2090]: Using 2 probe threads Oct 23 00:23:47.180584 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 23 00:23:47.180848 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 23 00:23:47.185753 kernel: fuse: init (API version 7.41) Oct 23 00:23:47.184000 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' Oct 23 00:23:47.184000 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' Oct 23 00:23:47.186047 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 23 00:23:47.186213 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 23 00:23:47.185000 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' Oct 23 00:23:47.185000 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' Oct 23 00:23:47.189010 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 23 00:23:47.197921 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 23 00:23:47.206503 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 23 00:23:47.207000 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' Oct 23 00:23:47.210823 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 23 00:23:47.213564 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 23 00:23:47.219705 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Oct 23 00:23:47.274581 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 23 00:23:47.278793 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 23 00:23:47.280291 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Oct 23 00:23:47.283850 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 23 00:23:47.362469 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 23 00:23:47.363000 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' Oct 23 00:23:47.366442 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 23 00:23:47.367000 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' Oct 23 00:23:47.369939 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 23 00:23:47.421278 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 23 00:23:47.424000 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' Oct 23 00:23:47.489255 systemd-journald[2086]: Time spent on flushing to /var/log/journal/2fe99fd3d48e4975a23b0b66b5d61f86 is 15.464ms for 1191 entries. Oct 23 00:23:47.489255 systemd-journald[2086]: System Journal (/var/log/journal/2fe99fd3d48e4975a23b0b66b5d61f86) is 8M, max 2.2G, 2.2G free. Oct 23 00:23:47.503000 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' Oct 23 00:23:47.657538 systemd-journald[2086]: Received client request to flush runtime journal. Oct 23 00:23:47.503041 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 23 00:23:47.505972 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 23 00:23:47.658110 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 23 00:23:47.657000 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' Oct 23 00:23:47.688597 systemd-tmpfiles[2095]: ACLs are not supported, ignoring. Oct 23 00:23:47.688619 systemd-tmpfiles[2095]: ACLs are not supported, ignoring. Oct 23 00:23:47.691060 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 23 00:23:47.693000 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' Oct 23 00:23:47.748428 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 23 00:23:47.748000 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' Oct 23 00:23:47.751387 kernel: kauditd_printk_skb: 26 callbacks suppressed Oct 23 00:23:47.751423 kernel: audit: type=1130 audit(1792715027.748:121): 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' Oct 23 00:23:48.012584 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 23 00:23:48.015000 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' Oct 23 00:23:48.019908 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 23 00:23:48.027420 kernel: audit: type=1130 audit(1792715028.015:122): 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' Oct 23 00:23:48.458950 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 23 00:23:48.459000 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' Oct 23 00:23:48.466851 kernel: audit: type=1130 audit(1792715028.459:123): 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' Oct 23 00:23:48.465568 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Oct 23 00:23:48.468000 audit: BPF prog-id=16 op=LOAD Oct 23 00:23:48.473750 kernel: audit: type=1334 audit(1792715028.468:124): prog-id=16 op=LOAD Oct 23 00:23:48.475878 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Oct 23 00:23:48.468000 audit: BPF prog-id=17 op=LOAD Oct 23 00:23:48.480748 kernel: audit: type=1334 audit(1792715028.468:125): prog-id=17 op=LOAD Oct 23 00:23:48.481940 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 23 00:23:48.468000 audit: BPF prog-id=18 op=LOAD Oct 23 00:23:48.479000 audit: BPF prog-id=19 op=LOAD Oct 23 00:23:48.487991 kernel: audit: type=1334 audit(1792715028.468:126): prog-id=18 op=LOAD Oct 23 00:23:48.488036 kernel: audit: type=1334 audit(1792715028.479:127): prog-id=19 op=LOAD Oct 23 00:23:48.488862 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 23 00:23:48.495473 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 23 00:23:48.500483 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Oct 23 00:23:48.504000 audit: BPF prog-id=20 op=LOAD Oct 23 00:23:48.510774 kernel: audit: type=1334 audit(1792715028.504:128): prog-id=20 op=LOAD Oct 23 00:23:48.507000 audit: BPF prog-id=21 op=LOAD Oct 23 00:23:48.513856 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 23 00:23:48.516868 kernel: audit: type=1334 audit(1792715028.507:129): prog-id=21 op=LOAD Oct 23 00:23:48.507000 audit: BPF prog-id=22 op=LOAD Oct 23 00:23:48.519770 kernel: audit: type=1334 audit(1792715028.507:130): prog-id=22 op=LOAD Oct 23 00:23:48.525717 systemd-tmpfiles[2156]: ACLs are not supported, ignoring. Oct 23 00:23:48.525746 systemd-tmpfiles[2156]: ACLs are not supported, ignoring. Oct 23 00:23:48.527918 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 23 00:23:48.528000 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' Oct 23 00:23:48.532172 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 23 00:23:48.534820 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Oct 23 00:23:48.534847 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 23 00:23:48.536382 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Oct 23 00:23:48.583233 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 23 00:23:48.586158 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 23 00:23:48.587699 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Oct 23 00:23:48.588490 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Oct 23 00:23:48.591657 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 23 00:23:48.593900 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Oct 23 00:23:48.603859 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Oct 23 00:23:48.606686 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 2158 ((systemd-userd)) Oct 23 00:23:48.609869 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Oct 23 00:23:48.671787 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Oct 23 00:23:48.673000 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' Oct 23 00:23:48.749707 systemd[1]: modprobe@tun.service: Deactivated successfully. Oct 23 00:23:48.749858 kernel: tun: Universal TUN/TAP device driver, 1.6 Oct 23 00:23:48.749929 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Oct 23 00:23:48.752000 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' Oct 23 00:23:48.752000 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' Oct 23 00:23:48.752000 audit: BPF prog-id=23 op=LOAD Oct 23 00:23:48.752000 audit: BPF prog-id=24 op=LOAD Oct 23 00:23:48.752000 audit: BPF prog-id=25 op=LOAD Oct 23 00:23:48.755162 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Oct 23 00:23:48.763762 kernel: loop4: detected capacity change from 0 to 44360 Oct 23 00:23:48.792329 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Oct 23 00:23:48.796850 kernel: loop4: p1 p2 p3 Oct 23 00:23:48.863024 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 23 00:23:48.863000 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' Oct 23 00:23:48.876742 systemd-nsresourced[2170]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Oct 23 00:23:48.877712 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Oct 23 00:23:48.879000 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' Oct 23 00:23:48.924799 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:48.924859 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:48.926361 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:48.928879 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:48.928545 systemd-confext[2165]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Oct 23 00:23:48.933008 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:48.974819 systemd-oomd[2154]: No swap; memory pressure usage will be degraded Oct 23 00:23:48.975517 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Oct 23 00:23:48.977000 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' Oct 23 00:23:49.024806 systemd-resolved[2155]: Positive Trust Anchors: Oct 23 00:23:49.024822 systemd-resolved[2155]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 23 00:23:49.024826 systemd-resolved[2155]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 23 00:23:49.024859 systemd-resolved[2155]: 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 Oct 23 00:23:49.197260 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 23 00:23:49.199000 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' Oct 23 00:23:49.199000 audit: BPF prog-id=7 op=UNLOAD Oct 23 00:23:49.199000 audit: BPF prog-id=6 op=UNLOAD Oct 23 00:23:49.200000 audit: BPF prog-id=26 op=LOAD Oct 23 00:23:49.200000 audit: BPF prog-id=27 op=LOAD Oct 23 00:23:49.202164 systemd-resolved[2155]: Using system hostname 'ci-4757.2.1-n-fba02c1b66'. Oct 23 00:23:49.203876 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 23 00:23:49.207933 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 23 00:23:49.207000 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' Oct 23 00:23:49.209681 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 23 00:23:49.452531 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 23 00:23:49.454000 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' Oct 23 00:23:49.495126 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 23 00:23:49.548377 systemd-udevd[2189]: Using default interface naming scheme 'v260'. Oct 23 00:23:49.860834 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 23 00:23:49.862000 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' Oct 23 00:23:49.863000 audit: BPF prog-id=28 op=LOAD Oct 23 00:23:49.867882 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 23 00:23:49.943937 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 23 00:23:50.192753 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#143 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 23 00:23:50.228738 kernel: mousedev: PS/2 mouse device common for all mice Oct 23 00:23:50.284870 kernel: hv_vmbus: registering driver hv_balloon Oct 23 00:23:50.286756 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Oct 23 00:23:50.297744 kernel: hv_vmbus: registering driver hyperv_fb Oct 23 00:23:50.300717 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Oct 23 00:23:50.300783 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Oct 23 00:23:50.301986 kernel: Console: switching to colour dummy device 80x25 Oct 23 00:23:50.306293 kernel: Console: switching to colour frame buffer device 128x48 Oct 23 00:23:50.426067 systemd-networkd[2192]: lo: Link UP Oct 23 00:23:50.426076 systemd-networkd[2192]: lo: Gained carrier Oct 23 00:23:50.427652 systemd-networkd[2192]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 23 00:23:50.427660 systemd-networkd[2192]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 23 00:23:50.428144 systemd[1]: Started systemd-networkd.service - Network Management. Oct 23 00:23:50.430750 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Oct 23 00:23:50.429000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:23:50.431040 systemd[1]: Reached target network.target - Network. Oct 23 00:23:50.433757 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Oct 23 00:23:50.435860 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 23 00:23:50.439821 kernel: hv_netvsc f8615163-0000-1000-2000-0022489e1d76 eth0: Data path switched to VF: enP30832s1 Oct 23 00:23:50.439238 systemd-networkd[2192]: enP30832s1: Link UP Oct 23 00:23:50.439330 systemd-networkd[2192]: eth0: Link UP Oct 23 00:23:50.439333 systemd-networkd[2192]: eth0: Gained carrier Oct 23 00:23:50.439349 systemd-networkd[2192]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 23 00:23:50.440848 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Oct 23 00:23:50.448087 systemd-networkd[2192]: enP30832s1: Gained carrier Oct 23 00:23:50.456821 systemd-networkd[2192]: eth0: DHCPv4 address 10.0.0.27/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 23 00:23:50.470997 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Oct 23 00:23:50.593487 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 23 00:23:50.619350 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 23 00:23:50.621000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-persistent-storage comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:23:50.692466 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 23 00:23:50.692702 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 23 00:23:50.694704 kernel: kvm_intel: Using Hyper-V Enlightened VMCS Oct 23 00:23:50.693000 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' Oct 23 00:23:50.693000 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' Oct 23 00:23:50.697744 kernel: cpu_based_exec_ctrl unsupported with eVMCS: 0x20000 Oct 23 00:23:50.699973 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 23 00:23:50.732750 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 23 00:23:50.861780 kernel: loop4: detected capacity change from 0 to 44360 Oct 23 00:23:50.897748 kernel: loop4: p1 p2 p3 Oct 23 00:23:50.968829 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:50.968878 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:50.968909 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:50.968980 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:50.969605 (sd-merge)[2267]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Oct 23 00:23:50.971755 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:50.997781 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 23 00:23:50.998193 (sd-merge)[2267]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 23 00:23:51.000682 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Oct 23 00:23:51.000000 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' Oct 23 00:23:51.006066 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 23 00:23:51.025743 kernel: loop5: detected capacity change from 0 to 388528 Oct 23 00:23:51.082822 kernel: loop5: p1 p2 p3 Oct 23 00:23:51.110750 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Oct 23 00:23:51.124930 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.125020 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:51.125152 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:51.126489 systemd-sysext[2279]: device-mapper: reload ioctl on loop5p1-63-verity (254:5) failed: Invalid argument Oct 23 00:23:51.126780 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:51.128813 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.129938 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 23 00:23:51.264238 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 23 00:23:51.262000 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' Oct 23 00:23:51.295744 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 23 00:23:51.329764 kernel: loop4: detected capacity change from 0 to 183832 Oct 23 00:23:51.336736 kernel: loop4: p1 p2 p3 Oct 23 00:23:51.344772 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.344822 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:51.344842 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:51.348041 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:51.348433 systemd-sysext[2279]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Oct 23 00:23:51.351743 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.364573 systemd-vconsole-setup[2261]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 23 00:23:51.366173 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 23 00:23:51.368000 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' Oct 23 00:23:51.379768 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 23 00:23:51.406747 kernel: loop4: detected capacity change from 0 to 137048 Oct 23 00:23:51.415799 kernel: loop4: p1 p2 p3 Oct 23 00:23:51.419802 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.419858 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:51.419875 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:51.421497 systemd-sysext[2279]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Oct 23 00:23:51.421735 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:51.424505 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.447746 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 23 00:23:51.468745 kernel: loop4: detected capacity change from 0 to 388528 Oct 23 00:23:51.474745 kernel: loop4: p1 p2 p3 Oct 23 00:23:51.482970 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.484192 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:51.484222 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:51.485172 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:51.485666 (sd-merge)[2314]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Oct 23 00:23:51.487738 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.525797 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 23 00:23:51.529342 kernel: loop5: detected capacity change from 0 to 183832 Oct 23 00:23:51.542741 kernel: loop5: p1 p2 p3 Oct 23 00:23:51.551766 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.551821 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:51.551840 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:51.554423 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:51.554872 (sd-merge)[2314]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Oct 23 00:23:51.556739 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.576749 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Oct 23 00:23:51.579770 kernel: loop6: detected capacity change from 0 to 137048 Oct 23 00:23:51.584759 kernel: loop6: p1 p2 p3 Oct 23 00:23:51.589107 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.589163 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 23 00:23:51.590210 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Oct 23 00:23:51.591136 kernel: device-mapper: ioctl: error adding target to table Oct 23 00:23:51.591371 (sd-merge)[2314]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Oct 23 00:23:51.593751 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 23 00:23:51.620778 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Oct 23 00:23:51.620878 (sd-merge)[2314]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 23 00:23:51.622630 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 23 00:23:51.623000 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' Oct 23 00:23:51.625250 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 23 00:23:51.650339 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/base_image_var.conf:29: Duplicate line for path "/var/log/audit", ignoring. Oct 23 00:23:51.651193 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/base_image_var_late.conf:44: Duplicate line for path "/var/log/audit", ignoring. Oct 23 00:23:51.651441 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/baselayout.conf:15: Duplicate line for path "/var", ignoring. Oct 23 00:23:51.651478 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/baselayout.conf:16: Duplicate line for path "/var/empty", ignoring. Oct 23 00:23:51.651513 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/baselayout.conf:21: Duplicate line for path "/var/log", ignoring. Oct 23 00:23:51.651630 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/dbus.conf:5: Duplicate line for path "/var/lib/dbus", ignoring. Oct 23 00:23:51.651908 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/nfs-utils.conf:2: Duplicate line for path "/var/lib/nfs/v4recovery", ignoring. Oct 23 00:23:51.665823 systemd-networkd[2192]: eth0: Gained IPv6LL Oct 23 00:23:51.667899 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 23 00:23:51.667899 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Oct 23 00:23:51.668732 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 23 00:23:51.668964 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 23 00:23:51.670011 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/tpm2-tss-fapi.conf:2: Duplicate line for path "/var/lib/tpm2-tss/system/keystore", ignoring. Oct 23 00:23:51.670027 systemd-tmpfiles[2336]: ACLs are not supported, ignoring. Oct 23 00:23:51.670073 systemd-tmpfiles[2336]: ACLs are not supported, ignoring. Oct 23 00:23:51.670769 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/var.conf:10: Duplicate line for path "/var", ignoring. Oct 23 00:23:51.670785 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 23 00:23:51.670856 systemd-tmpfiles[2336]: /usr/lib/tmpfiles.d/var.conf:21: Duplicate line for path "/var/lib", ignoring. Oct 23 00:23:51.670000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:23:51.671967 systemd[1]: Reached target network-online.target - Network is Online. Oct 23 00:23:51.674992 systemd-tmpfiles[2336]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 23 00:23:51.675002 systemd-tmpfiles[2336]: Skipping /boot Oct 23 00:23:51.679825 systemd-tmpfiles[2336]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 23 00:23:51.679833 systemd-tmpfiles[2336]: Skipping /boot Oct 23 00:23:51.686475 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 23 00:23:51.686000 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' Oct 23 00:23:51.690125 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 23 00:23:51.693903 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 23 00:23:51.698133 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 23 00:23:51.701096 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 23 00:23:51.705902 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 23 00:23:51.756000 audit[2344]: AUDIT1127 pid=2344 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' Oct 23 00:23:51.761285 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 23 00:23:51.761000 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' Oct 23 00:23:52.538000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 23 00:23:52.538000 audit[2367]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffe42443820 a2=420 a3=0 items=0 ppid=2340 pid=2367 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) Oct 23 00:23:52.538000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 23 00:23:52.540527 augenrules[2367]: No rules Oct 23 00:23:52.541595 systemd[1]: audit-rules.service: Deactivated successfully. Oct 23 00:23:52.541981 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 23 00:23:52.951658 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 23 00:23:54.200698 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 23 00:23:54.205079 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt skipped, unmet condition check ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt Oct 23 00:24:02.888199 ldconfig[2342]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 23 00:24:02.897088 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 23 00:24:02.901199 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 23 00:24:02.937672 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 23 00:24:02.939979 systemd[1]: Reached target sysinit.target - System Initialization. Oct 23 00:24:02.941402 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 23 00:24:02.942877 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 23 00:24:02.944492 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Oct 23 00:24:02.946101 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 23 00:24:02.948825 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 23 00:24:02.950513 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Oct 23 00:24:02.952126 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Oct 23 00:24:02.953534 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 23 00:24:02.956784 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Oct 23 00:24:02.956827 systemd[1]: Reached target paths.target - Path Units. Oct 23 00:24:02.959795 systemd[1]: Reached target timers.target - Timer Units. Oct 23 00:24:02.963140 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 23 00:24:02.965714 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 23 00:24:02.968409 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 23 00:24:02.973127 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 23 00:24:02.976128 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 23 00:24:02.979346 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Oct 23 00:24:02.983010 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 23 00:24:02.986348 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 23 00:24:02.988604 systemd[1]: Reached target sockets.target - Socket Units. Oct 23 00:24:02.989870 systemd[1]: Reached target basic.target - Basic System. Oct 23 00:24:02.991067 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Oct 23 00:24:02.991108 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Oct 23 00:24:02.992683 systemd[1]: Starting chronyd.service - NTP client/server... Oct 23 00:24:03.004367 systemd[1]: Starting containerd.service - containerd container runtime... Oct 23 00:24:03.011669 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 23 00:24:03.018098 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 23 00:24:03.022522 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 23 00:24:03.027917 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 23 00:24:03.030706 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Oct 23 00:24:03.032961 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Oct 23 00:24:03.035141 systemd[1]: hv_fcopy_uio_daemon.service - Hyper-V FCOPY UIO daemon skipped, unmet condition check ConditionPathExists=/sys/bus/vmbus/devices/eb765408-105f-49b6-b4aa-c123b64d17d4/uio Oct 23 00:24:03.036976 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Oct 23 00:24:03.040850 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Oct 23 00:24:03.042388 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 23 00:24:03.049954 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 23 00:24:03.055004 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 23 00:24:03.060885 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 23 00:24:03.070018 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 23 00:24:03.072857 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Oct 23 00:24:03.076891 jq[2384]: false Oct 23 00:24:03.077392 systemd[1]: Starting update-engine.service - Update Engine... Oct 23 00:24:03.083620 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 23 00:24:03.089229 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 23 00:24:03.092800 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 23 00:24:03.093023 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 23 00:24:03.093226 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 23 00:24:03.093393 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 23 00:24:03.109565 jq[2399]: true Oct 23 00:24:03.120971 jq[2415]: true Oct 23 00:24:03.182050 KVP[2387]: KVP starting; pid is:2387 Oct 23 00:24:03.200116 google_oslogin_nss_cache[2386]: oslogin_cache_refresh[2386]: Refreshing passwd entry cache Oct 23 00:24:03.200117 oslogin_cache_refresh[2386]: Refreshing passwd entry cache Oct 23 00:24:03.207655 google_oslogin_nss_cache[2386]: oslogin_cache_refresh[2386]: Failure getting users, quitting Oct 23 00:24:03.207655 google_oslogin_nss_cache[2386]: oslogin_cache_refresh[2386]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Oct 23 00:24:03.207645 oslogin_cache_refresh[2386]: Failure getting users, quitting Oct 23 00:24:03.207787 google_oslogin_nss_cache[2386]: oslogin_cache_refresh[2386]: Refreshing group entry cache Oct 23 00:24:03.207663 oslogin_cache_refresh[2386]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Oct 23 00:24:03.207708 oslogin_cache_refresh[2386]: Refreshing group entry cache Oct 23 00:24:03.214384 motdgen[2435]: /oem/oem-release: line 2: Azure: command not found Oct 23 00:24:03.214702 chronyd[2380]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Oct 23 00:24:03.218993 systemd[1]: motdgen.service: Deactivated successfully. Oct 23 00:24:03.219239 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 23 00:24:03.251700 google_oslogin_nss_cache[2386]: oslogin_cache_refresh[2386]: Failure getting groups, quitting Oct 23 00:24:03.251700 google_oslogin_nss_cache[2386]: oslogin_cache_refresh[2386]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Oct 23 00:24:03.251692 oslogin_cache_refresh[2386]: Failure getting groups, quitting Oct 23 00:24:03.251703 oslogin_cache_refresh[2386]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Oct 23 00:24:03.252711 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Oct 23 00:24:03.252982 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Oct 23 00:24:03.315138 KVP[2387]: KVP LIC Version: 3.1 Oct 23 00:24:03.315742 kernel: hv_utils: KVP IC version 4.0 Oct 23 00:24:03.352030 systemd-logind[2392]: New seat seat0. Oct 23 00:24:03.354569 systemd-logind[2392]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Oct 23 00:24:03.354872 systemd[1]: Started systemd-logind.service - User Login Management. Oct 23 00:24:03.381857 extend-filesystems[2385]: Found /dev/nvme0n1p6 Oct 23 00:24:03.479086 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 23 00:24:03.508385 extend-filesystems[2385]: Found /dev/nvme0n1p9 Oct 23 00:24:03.513947 extend-filesystems[2385]: Checking size of /dev/nvme0n1p9 Oct 23 00:24:03.515615 update_engine[2395]: I20261023 00:24:03.514991 2395 main.cc:92] Flatcar Update Engine starting Oct 23 00:24:03.566024 sshd_keygen[2409]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Oct 23 00:24:03.566919 chronyd[2380]: Timezone right/UTC failed leap second check, ignoring Oct 23 00:24:03.567701 chronyd[2380]: Loaded seccomp filter (level 2) Oct 23 00:24:03.568040 systemd[1]: Started chronyd.service - NTP client/server. Oct 23 00:24:03.590179 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 23 00:24:03.591895 extend-filesystems[2385]: Resized partition /dev/nvme0n1p9 Oct 23 00:24:03.595221 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 23 00:24:03.600949 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Oct 23 00:24:03.619305 systemd[1]: issuegen.service: Deactivated successfully. Oct 23 00:24:03.619540 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 23 00:24:03.631872 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 23 00:24:03.634676 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Oct 23 00:24:03.717300 bash[2441]: Updated "/home/core/.ssh/authorized_keys" Oct 23 00:24:03.719134 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 23 00:24:03.723283 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 23 00:24:03.729011 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 23 00:24:03.733491 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 23 00:24:03.736878 systemd[1]: Reached target getty.target - Login Prompts. Oct 23 00:24:03.740171 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Oct 23 00:24:03.741298 extend-filesystems[2494]: resize2fs 1.47.4 (6-Mar-2025) Oct 23 00:24:04.654750 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 6359552 to 6376955 blocks Oct 23 00:24:04.656756 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 6376955 Oct 23 00:24:04.699006 extend-filesystems[2494]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Oct 23 00:24:04.699006 extend-filesystems[2494]: old_desc_blocks = 4, new_desc_blocks = 4 Oct 23 00:24:04.699006 extend-filesystems[2494]: The filesystem on /dev/nvme0n1p9 is now 6376955 (4k) blocks long. Oct 23 00:24:04.706753 extend-filesystems[2385]: Resized filesystem in /dev/nvme0n1p9 Oct 23 00:24:04.703000 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 23 00:24:04.703261 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 23 00:24:05.081497 dbus-daemon[2382]: [system] SELinux support is enabled Oct 23 00:24:05.082089 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 23 00:24:05.087963 update_engine[2395]: I20261023 00:24:05.087795 2395 update_check_scheduler.cc:74] Next update check in 10m44s Oct 23 00:24:05.125413 systemd[1]: system-cloudinit@usr-share-coreos-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/coreos/cloud-config.yml skipped, unmet condition check ConditionFileNotEmpty=/usr/share/coreos/cloud-config.yml Oct 23 00:24:05.125454 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 23 00:24:05.126888 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline skipped, unmet condition check ConditionKernelCommandLine=cloud-config-url Oct 23 00:24:05.126911 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 23 00:24:05.137844 dbus-daemon[2382]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 23 00:24:05.139556 systemd[1]: Started update-engine.service - Update Engine. Oct 23 00:24:05.142189 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 23 00:24:06.031149 locksmithd[2510]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 23 00:24:10.443024 login[2501]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Oct 23 00:24:10.443025 login[2502]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Oct 23 00:24:10.449345 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 23 00:24:10.450394 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 23 00:24:10.454295 systemd-logind[2392]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Oct 23 00:24:10.459187 systemd-logind[2392]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Oct 23 00:24:10.510543 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 23 00:24:10.514079 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 23 00:24:10.514642 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 23 00:24:10.531890 containerd[2420]: time="2026-10-23T00:24:10Z" 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 Oct 23 00:24:10.533641 containerd[2420]: time="2026-10-23T00:24:10.533602799Z" level=info msg="starting containerd" revision=e53c7c1516c3b2bff98eb76f1f4117477e6f4e66 version=v2.2.5 Oct 23 00:24:10.545768 containerd[2420]: time="2026-10-23T00:24:10.545715559Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.872µs" Oct 23 00:24:10.545768 containerd[2420]: time="2026-10-23T00:24:10.545763406Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 23 00:24:10.545845 containerd[2420]: time="2026-10-23T00:24:10.545798658Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 23 00:24:10.545845 containerd[2420]: time="2026-10-23T00:24:10.545809874Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 23 00:24:10.545975 containerd[2420]: time="2026-10-23T00:24:10.545959628Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 23 00:24:10.546013 containerd[2420]: time="2026-10-23T00:24:10.545975628Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Oct 23 00:24:10.546013 containerd[2420]: time="2026-10-23T00:24:10.545987176Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 23 00:24:10.546057 containerd[2420]: time="2026-10-23T00:24:10.546031362Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 23 00:24:10.546057 containerd[2420]: time="2026-10-23T00:24:10.546040942Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 23 00:24:10.546223 containerd[2420]: time="2026-10-23T00:24:10.546205824Z" 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 Oct 23 00:24:10.546223 containerd[2420]: time="2026-10-23T00:24:10.546218822Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 23 00:24:10.546274 containerd[2420]: time="2026-10-23T00:24:10.546228849Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 23 00:24:10.546274 containerd[2420]: time="2026-10-23T00:24:10.546236549Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 23 00:24:10.546392 containerd[2420]: time="2026-10-23T00:24:10.546377280Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 23 00:24:10.546463 containerd[2420]: time="2026-10-23T00:24:10.546449977Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 23 00:24:10.546581 containerd[2420]: time="2026-10-23T00:24:10.546566344Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 23 00:24:10.546609 containerd[2420]: time="2026-10-23T00:24:10.546592425Z" 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 Oct 23 00:24:10.546609 containerd[2420]: time="2026-10-23T00:24:10.546602004Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 23 00:24:10.546651 containerd[2420]: time="2026-10-23T00:24:10.546639796Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 23 00:24:10.547272 containerd[2420]: time="2026-10-23T00:24:10.547247785Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 23 00:24:10.547344 containerd[2420]: time="2026-10-23T00:24:10.547329149Z" level=info msg="metadata content store policy set" policy=shared Oct 23 00:24:10.560136 containerd[2420]: time="2026-10-23T00:24:10.560104960Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 23 00:24:10.560195 containerd[2420]: time="2026-10-23T00:24:10.560149710Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 23 00:24:10.560195 containerd[2420]: time="2026-10-23T00:24:10.560176888Z" level=info msg="built-in NRI default validator is disabled" Oct 23 00:24:10.560195 containerd[2420]: time="2026-10-23T00:24:10.560184369Z" level=info msg="runtime interface created" Oct 23 00:24:10.560195 containerd[2420]: time="2026-10-23T00:24:10.560189038Z" level=info msg="created NRI interface" Oct 23 00:24:10.560278 containerd[2420]: time="2026-10-23T00:24:10.560198225Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 23 00:24:10.651885 containerd[2420]: time="2026-10-23T00:24:10.651856845Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Oct 23 00:24:10.652111 containerd[2420]: time="2026-10-23T00:24:10.652013507Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 23 00:24:10.652111 containerd[2420]: time="2026-10-23T00:24:10.652046282Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 23 00:24:10.652111 containerd[2420]: time="2026-10-23T00:24:10.652061860Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 23 00:24:10.652111 containerd[2420]: time="2026-10-23T00:24:10.652076469Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 23 00:24:10.652111 containerd[2420]: time="2026-10-23T00:24:10.652087740Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 23 00:24:10.652111 containerd[2420]: time="2026-10-23T00:24:10.652106060Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 23 00:24:10.652244 containerd[2420]: time="2026-10-23T00:24:10.652119308Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 23 00:24:10.652244 containerd[2420]: time="2026-10-23T00:24:10.652131276Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 23 00:24:10.652244 containerd[2420]: time="2026-10-23T00:24:10.652141867Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 23 00:24:10.652244 containerd[2420]: time="2026-10-23T00:24:10.652151491Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 23 00:24:10.652244 containerd[2420]: time="2026-10-23T00:24:10.652163057Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 23 00:24:10.652337 containerd[2420]: time="2026-10-23T00:24:10.652261465Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 23 00:24:10.652337 containerd[2420]: time="2026-10-23T00:24:10.652281882Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 23 00:24:10.652337 containerd[2420]: time="2026-10-23T00:24:10.652294085Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 23 00:24:10.652337 containerd[2420]: time="2026-10-23T00:24:10.652305155Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 23 00:24:10.652337 containerd[2420]: time="2026-10-23T00:24:10.652315328Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 23 00:24:10.652337 containerd[2420]: time="2026-10-23T00:24:10.652326337Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 23 00:24:10.652442 containerd[2420]: time="2026-10-23T00:24:10.652337236Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 23 00:24:10.652442 containerd[2420]: time="2026-10-23T00:24:10.652347764Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 23 00:24:10.652442 containerd[2420]: time="2026-10-23T00:24:10.652358782Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Oct 23 00:24:10.652442 containerd[2420]: time="2026-10-23T00:24:10.652367856Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 23 00:24:10.652442 containerd[2420]: time="2026-10-23T00:24:10.652379626Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 23 00:24:10.652442 containerd[2420]: time="2026-10-23T00:24:10.652388870Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 23 00:24:10.652442 containerd[2420]: time="2026-10-23T00:24:10.652411561Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 23 00:24:10.653137 containerd[2420]: time="2026-10-23T00:24:10.652525647Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 23 00:24:10.653137 containerd[2420]: time="2026-10-23T00:24:10.652539531Z" level=info msg="Start snapshots syncer" Oct 23 00:24:10.653137 containerd[2420]: time="2026-10-23T00:24:10.652565234Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 23 00:24:10.653859 containerd[2420]: time="2026-10-23T00:24:10.653812395Z" 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\"}" Oct 23 00:24:10.654343 containerd[2420]: time="2026-10-23T00:24:10.654053396Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 23 00:24:10.654484 containerd[2420]: time="2026-10-23T00:24:10.654428808Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 23 00:24:10.654710 containerd[2420]: time="2026-10-23T00:24:10.654642242Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 23 00:24:10.654710 containerd[2420]: time="2026-10-23T00:24:10.654670768Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 23 00:24:10.654710 containerd[2420]: time="2026-10-23T00:24:10.654685491Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 23 00:24:10.654710 containerd[2420]: time="2026-10-23T00:24:10.654696813Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 23 00:24:10.654879 containerd[2420]: time="2026-10-23T00:24:10.654858168Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 23 00:24:10.654879 containerd[2420]: time="2026-10-23T00:24:10.654878085Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 23 00:24:10.654937 containerd[2420]: time="2026-10-23T00:24:10.654889585Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 23 00:24:10.654937 containerd[2420]: time="2026-10-23T00:24:10.654903132Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 23 00:24:10.654937 containerd[2420]: time="2026-10-23T00:24:10.654913308Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 23 00:24:10.654991 containerd[2420]: time="2026-10-23T00:24:10.654955930Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 23 00:24:10.654991 containerd[2420]: time="2026-10-23T00:24:10.654971331Z" 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 Oct 23 00:24:10.654991 containerd[2420]: time="2026-10-23T00:24:10.654982286Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 23 00:24:10.655046 containerd[2420]: time="2026-10-23T00:24:10.654992235Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 23 00:24:10.655046 containerd[2420]: time="2026-10-23T00:24:10.655011068Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 23 00:24:10.655046 containerd[2420]: time="2026-10-23T00:24:10.655020818Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 23 00:24:10.655046 containerd[2420]: time="2026-10-23T00:24:10.655032148Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 23 00:24:10.655046 containerd[2420]: time="2026-10-23T00:24:10.655044301Z" level=info msg="Connect containerd service" Oct 23 00:24:10.655128 containerd[2420]: time="2026-10-23T00:24:10.655072215Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 23 00:24:10.655717 containerd[2420]: time="2026-10-23T00:24:10.655695294Z" 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" Oct 23 00:24:12.649297 containerd[2420]: time="2026-10-23T00:24:12.649229614Z" level=info msg="Start subscribing containerd event" Oct 23 00:24:12.650062 containerd[2420]: time="2026-10-23T00:24:12.649532730Z" level=info msg="Start recovering state" Oct 23 00:24:12.650062 containerd[2420]: time="2026-10-23T00:24:12.649569569Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 23 00:24:12.650062 containerd[2420]: time="2026-10-23T00:24:12.649609028Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 23 00:24:12.650062 containerd[2420]: time="2026-10-23T00:24:12.649732955Z" level=info msg="Start event monitor" Oct 23 00:24:12.650062 containerd[2420]: time="2026-10-23T00:24:12.649745003Z" level=info msg="Start cni network conf syncer for default" Oct 23 00:24:12.650062 containerd[2420]: time="2026-10-23T00:24:12.649758121Z" level=info msg="Start streaming server" Oct 23 00:24:12.650062 containerd[2420]: time="2026-10-23T00:24:12.649766471Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 23 00:24:12.650062 containerd[2420]: time="2026-10-23T00:24:12.649773565Z" level=info msg="runtime interface starting up..." Oct 23 00:24:12.650062 containerd[2420]: time="2026-10-23T00:24:12.649781051Z" level=info msg="starting plugins..." Oct 23 00:24:12.650062 containerd[2420]: time="2026-10-23T00:24:12.649792723Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 23 00:24:12.650653 containerd[2420]: time="2026-10-23T00:24:12.650556007Z" level=info msg="containerd successfully booted in 2.118898s" Oct 23 00:24:12.650938 systemd[1]: Started containerd.service - containerd container runtime. Oct 23 00:24:12.651403 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 23 00:24:12.652117 systemd[1]: Startup finished in 5.092s (kernel) + 19.083s (initrd) + 32.199s (userspace) = 56.376s. Oct 23 00:24:13.678412 waagent[2492]: 2026-10-23T00:24:13.678335Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.678709Z INFO Daemon Daemon OS: flatcar 4757.2.1 Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.678936Z INFO Daemon Daemon Python: 3.12.13 Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.679346Z INFO Daemon Daemon Run daemon Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.679882Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4757.2.1' Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.680213Z INFO Daemon Daemon Using waagent for provisioning Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.680383Z INFO Daemon Daemon Activate resource disk Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.680481Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.682271Z INFO Daemon Daemon Found device: None Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.682522Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.682896Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.683495Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 23 00:24:13.687267 waagent[2492]: 2026-10-23T00:24:13.683668Z INFO Daemon Daemon Running default provisioning handler Oct 23 00:24:13.692056 waagent[2492]: 2026-10-23T00:24:13.691679Z 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. Oct 23 00:24:13.694040 waagent[2492]: 2026-10-23T00:24:13.694002Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Oct 23 00:24:13.694301 waagent[2492]: 2026-10-23T00:24:13.694277Z INFO Daemon Daemon cloud-init is enabled: False Oct 23 00:24:13.694832 waagent[2492]: 2026-10-23T00:24:13.694809Z INFO Daemon Daemon Copying ovf-env.xml Oct 23 00:24:13.807176 waagent[2492]: 2026-10-23T00:24:13.807116Z INFO Daemon Daemon Successfully mounted dvd Oct 23 00:24:13.864143 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Oct 23 00:24:13.866086 waagent[2492]: 2026-10-23T00:24:13.865330Z INFO Daemon Daemon Detect protocol endpoint Oct 23 00:24:13.867065 waagent[2492]: 2026-10-23T00:24:13.867020Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 23 00:24:13.868587 waagent[2492]: 2026-10-23T00:24:13.868554Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Oct 23 00:24:13.870238 waagent[2492]: 2026-10-23T00:24:13.870210Z INFO Daemon Daemon Test for route to 168.63.129.16 Oct 23 00:24:13.871484 waagent[2492]: 2026-10-23T00:24:13.871452Z INFO Daemon Daemon Route to 168.63.129.16 exists Oct 23 00:24:13.872842 waagent[2492]: 2026-10-23T00:24:13.872815Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Oct 23 00:24:13.899811 waagent[2492]: 2026-10-23T00:24:13.899776Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Oct 23 00:24:13.901440 waagent[2492]: 2026-10-23T00:24:13.900136Z INFO Daemon Daemon Wire protocol version:2012-11-30 Oct 23 00:24:13.901440 waagent[2492]: 2026-10-23T00:24:13.900253Z INFO Daemon Daemon Server preferred version:2015-04-05 Oct 23 00:24:14.018029 waagent[2492]: 2026-10-23T00:24:14.017955Z INFO Daemon Daemon Initializing goal state during protocol detection Oct 23 00:24:14.019046 waagent[2492]: 2026-10-23T00:24:14.018242Z INFO Daemon Daemon Forcing an update of the goal state. Oct 23 00:24:14.029605 waagent[2492]: 2026-10-23T00:24:14.029563Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 23 00:24:14.044376 waagent[2492]: 2026-10-23T00:24:14.044337Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.189 Oct 23 00:24:14.046566 waagent[2492]: 2026-10-23T00:24:14.044865Z INFO Daemon Oct 23 00:24:14.046566 waagent[2492]: 2026-10-23T00:24:14.045127Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 0b0122f1-291f-4c28-898a-c0ebe2bb0103 eTag: 6145596713100224917 source: Fabric] Oct 23 00:24:14.046566 waagent[2492]: 2026-10-23T00:24:14.045397Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Oct 23 00:24:14.046566 waagent[2492]: 2026-10-23T00:24:14.045768Z INFO Daemon Oct 23 00:24:14.046566 waagent[2492]: 2026-10-23T00:24:14.045936Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Oct 23 00:24:14.052893 waagent[2492]: 2026-10-23T00:24:14.050038Z INFO Daemon Daemon Downloading artifacts profile blob Oct 23 00:24:14.165521 waagent[2492]: 2026-10-23T00:24:14.165470Z INFO Daemon Downloaded certificate {'thumbprint': 'DBCFBB822DF7A162FB9A28D32CE5B1A1F11CB4A1', 'hasPrivateKey': True} Oct 23 00:24:14.168044 waagent[2492]: 2026-10-23T00:24:14.168009Z INFO Daemon Fetch goal state completed Oct 23 00:24:14.176022 waagent[2492]: 2026-10-23T00:24:14.175974Z INFO Daemon Daemon Starting provisioning Oct 23 00:24:14.176940 waagent[2492]: 2026-10-23T00:24:14.176908Z INFO Daemon Daemon Handle ovf-env.xml. Oct 23 00:24:14.177699 waagent[2492]: 2026-10-23T00:24:14.177280Z INFO Daemon Daemon Set hostname [ci-4757.2.1-n-fba02c1b66] Oct 23 00:24:14.180359 waagent[2492]: 2026-10-23T00:24:14.180315Z INFO Daemon Daemon Publish hostname [ci-4757.2.1-n-fba02c1b66] Oct 23 00:24:14.181446 waagent[2492]: 2026-10-23T00:24:14.180616Z INFO Daemon Daemon Examine /proc/net/route for primary interface Oct 23 00:24:14.181446 waagent[2492]: 2026-10-23T00:24:14.181061Z INFO Daemon Daemon Primary interface is [eth0] Oct 23 00:24:14.188129 systemd-networkd[2192]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 23 00:24:14.188138 systemd-networkd[2192]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Oct 23 00:24:14.188164 systemd-networkd[2192]: eth0: DHCP lease lost Oct 23 00:24:14.201917 waagent[2492]: 2026-10-23T00:24:14.201872Z INFO Daemon Daemon Create user account if not exists Oct 23 00:24:14.209634 waagent[2492]: 2026-10-23T00:24:14.202105Z INFO Daemon Daemon User core already exists, skip useradd Oct 23 00:24:14.209634 waagent[2492]: 2026-10-23T00:24:14.202308Z INFO Daemon Daemon Configure sudoer Oct 23 00:24:14.209634 waagent[2492]: 2026-10-23T00:24:14.203249Z INFO Daemon Daemon Configure sshd Oct 23 00:24:14.209634 waagent[2492]: 2026-10-23T00:24:14.204104Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Oct 23 00:24:14.209634 waagent[2492]: 2026-10-23T00:24:14.204281Z INFO Daemon Daemon Deploy ssh public key. Oct 23 00:24:14.216832 systemd-networkd[2192]: eth0: DHCPv4 address 10.0.0.27/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 23 00:24:15.286977 waagent[2492]: 2026-10-23T00:24:15.286928Z INFO Daemon Daemon Provisioning complete Oct 23 00:24:15.294474 waagent[2492]: 2026-10-23T00:24:15.294437Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Oct 23 00:24:15.300389 waagent[2492]: 2026-10-23T00:24:15.294672Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Oct 23 00:24:15.300389 waagent[2492]: 2026-10-23T00:24:15.294927Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Oct 23 00:24:15.410047 waagent[2599]: 2026-10-23T00:24:15.409968Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Oct 23 00:24:15.410391 waagent[2599]: 2026-10-23T00:24:15.410084Z INFO ExtHandler ExtHandler OS: flatcar 4757.2.1 Oct 23 00:24:15.410391 waagent[2599]: 2026-10-23T00:24:15.410137Z INFO ExtHandler ExtHandler Python: 3.12.13 Oct 23 00:24:15.410391 waagent[2599]: 2026-10-23T00:24:15.410179Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Oct 23 00:24:15.463715 waagent[2599]: 2026-10-23T00:24:15.463654Z INFO ExtHandler ExtHandler Distro: flatcar-4757.2.1; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.13; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Oct 23 00:24:15.463912 waagent[2599]: 2026-10-23T00:24:15.463882Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 23 00:24:15.463976 waagent[2599]: 2026-10-23T00:24:15.463953Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 23 00:24:15.473703 waagent[2599]: 2026-10-23T00:24:15.473637Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 23 00:24:15.490220 waagent[2599]: 2026-10-23T00:24:15.490189Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.189 Oct 23 00:24:15.490594 waagent[2599]: 2026-10-23T00:24:15.490563Z INFO ExtHandler Oct 23 00:24:15.490670 waagent[2599]: 2026-10-23T00:24:15.490632Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 4a6b528c-22e7-4b28-9cb2-e84c110402b0 eTag: 6145596713100224917 source: Fabric] Oct 23 00:24:15.490924 waagent[2599]: 2026-10-23T00:24:15.490900Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Oct 23 00:24:15.491300 waagent[2599]: 2026-10-23T00:24:15.491276Z INFO ExtHandler Oct 23 00:24:15.491356 waagent[2599]: 2026-10-23T00:24:15.491332Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Oct 23 00:24:15.495516 waagent[2599]: 2026-10-23T00:24:15.495491Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Oct 23 00:24:15.577838 waagent[2599]: 2026-10-23T00:24:15.577745Z INFO ExtHandler Downloaded certificate {'thumbprint': 'DBCFBB822DF7A162FB9A28D32CE5B1A1F11CB4A1', 'hasPrivateKey': True} Oct 23 00:24:15.578191 waagent[2599]: 2026-10-23T00:24:15.578157Z INFO ExtHandler Fetch goal state completed Oct 23 00:24:15.588288 waagent[2599]: 2026-10-23T00:24:15.588242Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.9 29 Sep 2026 (Library: OpenSSL 3.5.9 29 Sep 2026) Oct 23 00:24:15.591388 waagent[2599]: 2026-10-23T00:24:15.591341Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2599 Oct 23 00:24:15.591507 waagent[2599]: 2026-10-23T00:24:15.591481Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Oct 23 00:24:15.591789 waagent[2599]: 2026-10-23T00:24:15.591756Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Oct 23 00:24:15.592899 waagent[2599]: 2026-10-23T00:24:15.592867Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4757.2.1', '', 'Flatcar Container Linux by Kinvolk'] Oct 23 00:24:15.593210 waagent[2599]: 2026-10-23T00:24:15.593184Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4757.2.1', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Oct 23 00:24:15.593319 waagent[2599]: 2026-10-23T00:24:15.593297Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Oct 23 00:24:15.593807 waagent[2599]: 2026-10-23T00:24:15.593772Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Oct 23 00:24:15.611163 waagent[2599]: 2026-10-23T00:24:15.611134Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Oct 23 00:24:15.611314 waagent[2599]: 2026-10-23T00:24:15.611290Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Oct 23 00:24:15.616206 waagent[2599]: 2026-10-23T00:24:15.615819Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Oct 23 00:24:15.620469 systemd[1]: Reload requested from client PID 2614 ('systemctl') (unit waagent.service)... Oct 23 00:24:15.620484 systemd[1]: Reloading... Oct 23 00:24:15.696754 zram_generator::config[2658]: No configuration found. Oct 23 00:24:15.937871 systemd[1]: Reloading finished in 317 ms. Oct 23 00:24:15.961737 waagent[2599]: 2026-10-23T00:24:15.960291Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Oct 23 00:24:15.961737 waagent[2599]: 2026-10-23T00:24:15.960442Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Oct 23 00:24:16.313834 waagent[2599]: 2026-10-23T00:24:16.313766Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Oct 23 00:24:16.314113 waagent[2599]: 2026-10-23T00:24:16.314086Z 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] Oct 23 00:24:16.314960 waagent[2599]: 2026-10-23T00:24:16.314708Z INFO ExtHandler ExtHandler Starting env monitor service. Oct 23 00:24:16.314960 waagent[2599]: 2026-10-23T00:24:16.314927Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 23 00:24:16.315043 waagent[2599]: 2026-10-23T00:24:16.315011Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 23 00:24:16.315216 waagent[2599]: 2026-10-23T00:24:16.315192Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Oct 23 00:24:16.315542 waagent[2599]: 2026-10-23T00:24:16.315515Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Oct 23 00:24:16.315542 waagent[2599]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Oct 23 00:24:16.315542 waagent[2599]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Oct 23 00:24:16.315542 waagent[2599]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Oct 23 00:24:16.315542 waagent[2599]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Oct 23 00:24:16.315542 waagent[2599]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 23 00:24:16.315542 waagent[2599]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 23 00:24:16.316017 waagent[2599]: 2026-10-23T00:24:16.315984Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 23 00:24:16.316080 waagent[2599]: 2026-10-23T00:24:16.316058Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 23 00:24:16.316210 waagent[2599]: 2026-10-23T00:24:16.316186Z INFO EnvHandler ExtHandler Configure routes Oct 23 00:24:16.316278 waagent[2599]: 2026-10-23T00:24:16.316244Z INFO EnvHandler ExtHandler Gateway:None Oct 23 00:24:16.316338 waagent[2599]: 2026-10-23T00:24:16.316306Z INFO EnvHandler ExtHandler Routes:None Oct 23 00:24:16.316503 waagent[2599]: 2026-10-23T00:24:16.316474Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Oct 23 00:24:16.316879 waagent[2599]: 2026-10-23T00:24:16.316849Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Oct 23 00:24:16.316922 waagent[2599]: 2026-10-23T00:24:16.316885Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Oct 23 00:24:16.317133 waagent[2599]: 2026-10-23T00:24:16.317106Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Oct 23 00:24:16.317231 waagent[2599]: 2026-10-23T00:24:16.317210Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Oct 23 00:24:16.317613 waagent[2599]: 2026-10-23T00:24:16.317592Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Oct 23 00:24:16.327503 waagent[2599]: 2026-10-23T00:24:16.327470Z INFO ExtHandler ExtHandler Oct 23 00:24:16.327568 waagent[2599]: 2026-10-23T00:24:16.327537Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: a3e30b62-465e-4891-875c-0924efcaceae correlation 5befefea-25f8-40bd-8045-be3b11391924 created: 2026-10-23T00:22:55.700302Z] Oct 23 00:24:16.327843 waagent[2599]: 2026-10-23T00:24:16.327819Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Oct 23 00:24:16.328253 waagent[2599]: 2026-10-23T00:24:16.328228Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Oct 23 00:24:16.360945 waagent[2599]: 2026-10-23T00:24:16.360903Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: D79CDD7D-A0B5-4494-9F7B-2E407B1D8544;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Oct 23 00:24:16.415598 waagent[2599]: 2026-10-23T00:24:16.415546Z INFO MonitorHandler ExtHandler Network interfaces: Oct 23 00:24:16.415598 waagent[2599]: Executing ['ip', '-a', '-o', 'link']: Oct 23 00:24:16.415598 waagent[2599]: 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 Oct 23 00:24:16.415598 waagent[2599]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:9e:1d:76 brd ff:ff:ff:ff:ff:ff\ alias Network Device\ altname enx0022489e1d76 Oct 23 00:24:16.415598 waagent[2599]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:9e:1d:76 brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0\ altname enp0s0\ altname ens1 Oct 23 00:24:16.415598 waagent[2599]: Executing ['ip', '-4', '-a', '-o', 'address']: Oct 23 00:24:16.415598 waagent[2599]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Oct 23 00:24:16.415598 waagent[2599]: 2: eth0 inet 10.0.0.27/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Oct 23 00:24:16.415598 waagent[2599]: Executing ['ip', '-6', '-a', '-o', 'address']: Oct 23 00:24:16.415598 waagent[2599]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Oct 23 00:24:16.415598 waagent[2599]: 2: eth0 inet6 fe80::222:48ff:fe9e:1d76/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Oct 23 00:24:16.461503 waagent[2599]: 2026-10-23T00:24:16.461455Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Oct 23 00:24:16.461503 waagent[2599]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 23 00:24:16.461503 waagent[2599]: pkts bytes target prot opt in out source destination Oct 23 00:24:16.461503 waagent[2599]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 23 00:24:16.461503 waagent[2599]: pkts bytes target prot opt in out source destination Oct 23 00:24:16.461503 waagent[2599]: Chain OUTPUT (policy ACCEPT 2 packets, 289 bytes) Oct 23 00:24:16.461503 waagent[2599]: pkts bytes target prot opt in out source destination Oct 23 00:24:16.461503 waagent[2599]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 23 00:24:16.461503 waagent[2599]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 23 00:24:16.461503 waagent[2599]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 23 00:24:16.464010 waagent[2599]: 2026-10-23T00:24:16.463967Z INFO EnvHandler ExtHandler Current Firewall rules: Oct 23 00:24:16.464010 waagent[2599]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 23 00:24:16.464010 waagent[2599]: pkts bytes target prot opt in out source destination Oct 23 00:24:16.464010 waagent[2599]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 23 00:24:16.464010 waagent[2599]: pkts bytes target prot opt in out source destination Oct 23 00:24:16.464010 waagent[2599]: Chain OUTPUT (policy ACCEPT 2 packets, 289 bytes) Oct 23 00:24:16.464010 waagent[2599]: pkts bytes target prot opt in out source destination Oct 23 00:24:16.464010 waagent[2599]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 23 00:24:16.464010 waagent[2599]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 23 00:24:16.464010 waagent[2599]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 23 00:24:27.348356 chronyd[2380]: Selected source PHC0 Oct 23 00:24:38.429180 kernel: hv_balloon: Max. dynamic memory size: 8192 MB Oct 23 00:24:41.860242 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 23 00:24:41.861422 systemd[1]: Started sshd@0-1-10.0.0.27:22-20.31.226.197:33842.service - OpenSSH per-connection server daemon (20.31.226.197:33842). Oct 23 00:24:42.216864 sshd[2754]: Accepted publickey for core from 20.31.226.197 port 33842 ssh2: RSA SHA256:8SYE0xMkdaIbK6kpMpYPW0/QImDQGwhSHxGbZ30sa2E Oct 23 00:24:42.218132 sshd-session[2754]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 23 00:24:42.234737 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 23 00:24:42.237878 systemd-logind[2392]: New session '3' of user 'core' with class 'user' and type 'tty'. Oct 23 00:24:42.243567 (systemd)[2758]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Oct 23 00:24:42.245580 systemd-logind[2392]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Oct 23 00:24:42.528013 systemd[2758]: Queued start job for default target default.target. Oct 23 00:24:42.539470 systemd[2758]: Created slice app.slice - User Application Slice. Oct 23 00:24:42.539501 systemd[2758]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Oct 23 00:24:42.539515 systemd[2758]: Reached target machines.target - Virtual Machines and Containers. Oct 23 00:24:42.539563 systemd[2758]: Reached target paths.target - Paths. Oct 23 00:24:42.539589 systemd[2758]: Reached target timers.target - Timers. Oct 23 00:24:42.540553 systemd[2758]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 23 00:24:42.542258 systemd[2758]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 23 00:24:42.542409 systemd[2758]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 23 00:24:42.543435 systemd[2758]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 23 00:24:42.543657 systemd[2758]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 23 00:24:42.544322 systemd[2758]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Oct 23 00:24:42.553510 systemd[2758]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 23 00:24:42.553714 systemd[2758]: Reached target sockets.target - Sockets. Oct 23 00:24:42.555320 systemd[2758]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Oct 23 00:24:42.555413 systemd[2758]: Reached target basic.target - Basic System. Oct 23 00:24:42.555461 systemd[2758]: Reached target default.target - Main User Target. Oct 23 00:24:42.555484 systemd[2758]: Startup finished in 305ms. Oct 23 00:24:42.555641 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 23 00:24:42.568202 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 23 00:24:42.628268 systemd[1]: Started sshd@1-4097-10.0.0.27:22-20.31.226.197:33858.service - OpenSSH per-connection server daemon (20.31.226.197:33858). Oct 23 00:24:42.737506 sshd[2772]: Accepted publickey for core from 20.31.226.197 port 33858 ssh2: RSA SHA256:8SYE0xMkdaIbK6kpMpYPW0/QImDQGwhSHxGbZ30sa2E Oct 23 00:24:42.738544 sshd-session[2772]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 23 00:24:42.742993 systemd-logind[2392]: New session '5' of user 'core' with class 'user' and type 'tty'. Oct 23 00:24:42.748881 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 23 00:24:42.784667 sshd[2776]: Connection closed by 20.31.226.197 port 33858 Oct 23 00:24:42.785988 sshd-session[2772]: pam_unix(sshd:session): session closed for user core Oct 23 00:24:42.788068 systemd[1]: sshd@1-4097-10.0.0.27:22-20.31.226.197:33858.service: Deactivated successfully. Oct 23 00:24:42.789314 systemd[1]: session-5.scope: Deactivated successfully. Oct 23 00:24:42.790150 systemd-logind[2392]: Session 5 logged out. Waiting for processes to exit. Oct 23 00:24:42.791292 systemd-logind[2392]: Removed session 5. Oct 23 00:24:42.820069 systemd[1]: Started sshd@2-2-10.0.0.27:22-20.31.226.197:33864.service - OpenSSH per-connection server daemon (20.31.226.197:33864). Oct 23 00:24:42.923369 sshd[2782]: Accepted publickey for core from 20.31.226.197 port 33864 ssh2: RSA SHA256:8SYE0xMkdaIbK6kpMpYPW0/QImDQGwhSHxGbZ30sa2E Oct 23 00:24:42.923882 sshd-session[2782]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 23 00:24:42.927769 systemd-logind[2392]: New session '6' of user 'core' with class 'user' and type 'tty'. Oct 23 00:24:42.938885 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 23 00:24:42.971711 sshd[2786]: Connection closed by 20.31.226.197 port 33864 Oct 23 00:24:42.972965 sshd-session[2782]: pam_unix(sshd:session): session closed for user core Oct 23 00:24:42.974867 systemd[1]: sshd@2-2-10.0.0.27:22-20.31.226.197:33864.service: Deactivated successfully. Oct 23 00:24:42.976241 systemd[1]: session-6.scope: Deactivated successfully. Oct 23 00:24:42.976915 systemd-logind[2392]: Session 6 logged out. Waiting for processes to exit. Oct 23 00:24:42.977951 systemd-logind[2392]: Removed session 6. Oct 23 00:24:42.992078 systemd[1]: Started sshd@3-3-10.0.0.27:22-20.31.226.197:33866.service - OpenSSH per-connection server daemon (20.31.226.197:33866). Oct 23 00:24:43.100185 sshd[2793]: Accepted publickey for core from 20.31.226.197 port 33866 ssh2: RSA SHA256:8SYE0xMkdaIbK6kpMpYPW0/QImDQGwhSHxGbZ30sa2E Oct 23 00:24:43.101400 sshd-session[2793]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 23 00:24:43.105604 systemd-logind[2392]: New session '7' of user 'core' with class 'user' and type 'tty'. Oct 23 00:24:43.111881 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 23 00:24:43.147377 sshd[2797]: Connection closed by 20.31.226.197 port 33866 Oct 23 00:24:43.147851 sshd-session[2793]: pam_unix(sshd:session): session closed for user core Oct 23 00:24:43.149626 systemd[1]: sshd@3-3-10.0.0.27:22-20.31.226.197:33866.service: Deactivated successfully. Oct 23 00:24:43.150885 systemd[1]: session-7.scope: Deactivated successfully. Oct 23 00:24:43.152451 systemd-logind[2392]: Session 7 logged out. Waiting for processes to exit. Oct 23 00:24:43.153144 systemd-logind[2392]: Removed session 7. Oct 23 00:24:43.171991 systemd[1]: Started sshd@4-4098-10.0.0.27:22-20.31.226.197:33870.service - OpenSSH per-connection server daemon (20.31.226.197:33870). Oct 23 00:24:43.282013 sshd[2803]: Accepted publickey for core from 20.31.226.197 port 33870 ssh2: RSA SHA256:8SYE0xMkdaIbK6kpMpYPW0/QImDQGwhSHxGbZ30sa2E Oct 23 00:24:43.282993 sshd-session[2803]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 23 00:24:43.287246 systemd-logind[2392]: New session '8' of user 'core' with class 'user' and type 'tty'. Oct 23 00:24:43.299897 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 23 00:24:43.482932 sudo[2808]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 23 00:24:43.483159 sudo[2808]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 23 00:24:43.510464 sudo[2808]: pam_unix(sudo:session): session closed for user root Oct 23 00:24:43.525190 sshd[2807]: Connection closed by 20.31.226.197 port 33870 Oct 23 00:24:43.525903 sshd-session[2803]: pam_unix(sshd:session): session closed for user core Oct 23 00:24:43.528270 systemd[1]: sshd@4-4098-10.0.0.27:22-20.31.226.197:33870.service: Deactivated successfully. Oct 23 00:24:43.529559 systemd[1]: session-8.scope: Deactivated successfully. Oct 23 00:24:43.530272 systemd-logind[2392]: Session 8 logged out. Waiting for processes to exit. Oct 23 00:24:43.531374 systemd-logind[2392]: Removed session 8. Oct 23 00:24:43.546191 systemd[1]: Started sshd@5-4099-10.0.0.27:22-20.31.226.197:33884.service - OpenSSH per-connection server daemon (20.31.226.197:33884). Oct 23 00:24:43.656806 sshd[2816]: Accepted publickey for core from 20.31.226.197 port 33884 ssh2: RSA SHA256:8SYE0xMkdaIbK6kpMpYPW0/QImDQGwhSHxGbZ30sa2E Oct 23 00:24:43.657692 sshd-session[2816]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 23 00:24:43.661963 systemd-logind[2392]: New session '9' of user 'core' with class 'user' and type 'tty'. Oct 23 00:24:43.672869 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 23 00:24:43.696270 sudo[2822]: 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 Oct 23 00:24:43.696508 sudo[2822]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 23 00:24:43.698505 sudo[2822]: pam_unix(sudo:session): session closed for user root Oct 23 00:24:43.703354 sudo[2821]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 23 00:24:43.703591 sudo[2821]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 23 00:24:43.709272 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 23 00:24:43.763000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 23 00:24:43.771716 kernel: kauditd_printk_skb: 34 callbacks suppressed Oct 23 00:24:43.771780 kernel: audit: type=1305 audit(1792715083.763:163): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 23 00:24:43.763000 audit[2846]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffd6e2af6d0 a2=420 a3=0 items=0 ppid=2827 pid=2846 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) Oct 23 00:24:43.774137 augenrules[2846]: No rules Oct 23 00:24:43.774251 systemd[1]: audit-rules.service: Deactivated successfully. Oct 23 00:24:43.763000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 23 00:24:43.775447 kernel: audit: type=1300 audit(1792715083.763:163): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffd6e2af6d0 a2=420 a3=0 items=0 ppid=2827 pid=2846 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) Oct 23 00:24:43.774464 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 23 00:24:43.775527 kernel: audit: type=1327 audit(1792715083.763:163): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 23 00:24:43.774000 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' Oct 23 00:24:43.777298 sudo[2821]: pam_unix(sudo:session): session closed for user root Oct 23 00:24:43.778220 kernel: audit: type=1130 audit(1792715083.774:164): 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' Oct 23 00:24:43.774000 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' Oct 23 00:24:43.776000 audit[2821]: AUDIT1106 pid=2821 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' Oct 23 00:24:43.776000 audit[2821]: AUDIT1104 pid=2821 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' Oct 23 00:24:43.781949 kernel: audit: type=1131 audit(1792715083.774:165): 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' Oct 23 00:24:43.782026 kernel: audit: type=1106 audit(1792715083.776:166): pid=2821 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' Oct 23 00:24:43.782043 kernel: audit: type=1104 audit(1792715083.776:167): pid=2821 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' Oct 23 00:24:43.792059 sshd[2820]: Connection closed by 20.31.226.197 port 33884 Oct 23 00:24:43.792859 sshd-session[2816]: pam_unix(sshd:session): session closed for user core Oct 23 00:24:43.792000 audit[2816]: AUDIT1106 pid=2816 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=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 23 00:24:43.796735 kernel: audit: type=1106 audit(1792715083.792:168): pid=2816 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=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 23 00:24:43.792000 audit[2816]: AUDIT1104 pid=2816 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=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 23 00:24:43.798139 systemd[1]: sshd@5-4099-10.0.0.27:22-20.31.226.197:33884.service: Deactivated successfully. Oct 23 00:24:43.798000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4099-10.0.0.27:22-20.31.226.197:33884 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:24:43.803949 kernel: audit: type=1104 audit(1792715083.792:169): pid=2816 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=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 23 00:24:43.800651 systemd[1]: session-9.scope: Deactivated successfully. Oct 23 00:24:43.804021 kernel: audit: type=1131 audit(1792715083.798:170): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4099-10.0.0.27:22-20.31.226.197:33884 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:24:43.802709 systemd-logind[2392]: Session 9 logged out. Waiting for processes to exit. Oct 23 00:24:43.804889 systemd-logind[2392]: Removed session 9. Oct 23 00:24:43.816000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4-10.0.0.27:22-20.31.226.197:33888 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:24:43.816945 systemd[1]: Started sshd@6-4-10.0.0.27:22-20.31.226.197:33888.service - OpenSSH per-connection server daemon (20.31.226.197:33888). Oct 23 00:24:43.926000 audit[2855]: AUDIT1101 pid=2855 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=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 23 00:24:43.927478 sshd[2855]: Accepted publickey for core from 20.31.226.197 port 33888 ssh2: RSA SHA256:8SYE0xMkdaIbK6kpMpYPW0/QImDQGwhSHxGbZ30sa2E Oct 23 00:24:43.927000 audit[2855]: AUDIT1103 pid=2855 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=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 23 00:24:43.927000 audit[2855]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7fff51074da0 a2=3 a3=0 items=0 ppid=1 pid=2855 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) Oct 23 00:24:43.927000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Oct 23 00:24:43.928546 sshd-session[2855]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 23 00:24:43.934066 systemd-logind[2392]: New session '10' of user 'core' with class 'user' and type 'tty'. Oct 23 00:24:43.940901 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 23 00:24:43.942000 audit[2855]: AUDIT1105 pid=2855 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=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 23 00:24:43.943000 audit[2859]: AUDIT1103 pid=2859 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=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 23 00:24:43.992587 sshd[2859]: Connection closed by 20.31.226.197 port 33888 Oct 23 00:24:43.993878 sshd-session[2855]: pam_unix(sshd:session): session closed for user core Oct 23 00:24:43.993000 audit[2855]: AUDIT1106 pid=2855 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=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 23 00:24:43.993000 audit[2855]: AUDIT1104 pid=2855 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=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 23 00:24:43.996052 systemd[1]: sshd@6-4-10.0.0.27:22-20.31.226.197:33888.service: Deactivated successfully. Oct 23 00:24:43.995000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4-10.0.0.27:22-20.31.226.197:33888 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 23 00:24:43.997448 systemd[1]: session-10.scope: Deactivated successfully. Oct 23 00:24:43.998251 systemd-logind[2392]: Session 10 logged out. Waiting for processes to exit. Oct 23 00:24:43.999410 systemd-logind[2392]: Removed session 10.