Apr 14 23:47:41.987140 kernel: Linux version 6.12.81-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 15.2.1_p20251122 p4) 15.2.1 20251122, GNU ld (Gentoo 2.45.1 p1) 2.45.1) #1 SMP PREEMPT_DYNAMIC Tue Apr 14 21:54:45 -00 2026 Apr 14 23:47:41.987197 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=52685ba3ad3b9487d80aa4b833bfcf53bab81ab3d8190006a0e18c9734938056 Apr 14 23:47:41.987211 kernel: BIOS-provided physical RAM map: Apr 14 23:47:41.987220 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Apr 14 23:47:41.987231 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Apr 14 23:47:41.987242 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000044fdfff] usable Apr 14 23:47:41.987257 kernel: BIOS-e820: [mem 0x00000000044fe000-0x00000000048fdfff] reserved Apr 14 23:47:41.987263 kernel: BIOS-e820: [mem 0x00000000048fe000-0x000000003ff1efff] usable Apr 14 23:47:41.987273 kernel: BIOS-e820: [mem 0x000000003ff1f000-0x000000003ffc8fff] reserved Apr 14 23:47:41.987283 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Apr 14 23:47:41.987295 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Apr 14 23:47:41.987304 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Apr 14 23:47:41.987311 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable Apr 14 23:47:41.987323 kernel: printk: legacy bootconsole [earlyser0] enabled Apr 14 23:47:41.987335 kernel: NX (Execute Disable) protection: active Apr 14 23:47:41.987344 kernel: APIC: Static calls initialized Apr 14 23:47:41.987352 kernel: efi: EFI v2.7 by Microsoft Apr 14 23:47:41.989358 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff88000 SMBIOS 3.0=0x3ff86000 MEMATTR=0x3ea95018 RNG=0x3ffd2018 Apr 14 23:47:41.989370 kernel: random: crng init done Apr 14 23:47:41.989379 kernel: secureboot: Secure boot disabled Apr 14 23:47:41.989385 kernel: SMBIOS 3.1.0 present. Apr 14 23:47:41.989394 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 01/08/2026 Apr 14 23:47:41.989431 kernel: DMI: Memory slots populated: 2/2 Apr 14 23:47:41.989440 kernel: Hypervisor detected: Microsoft Hyper-V Apr 14 23:47:41.989446 kernel: Hyper-V: privilege flags low 0xae7f, high 0x3b8030, hints 0x9e4e24, misc 0xe0bed7b2 Apr 14 23:47:41.989454 kernel: Hyper-V: Nested features: 0x3e0101 Apr 14 23:47:41.989460 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Apr 14 23:47:41.989469 kernel: Hyper-V: Using hypercall for remote TLB flush Apr 14 23:47:41.989478 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Apr 14 23:47:41.989487 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Apr 14 23:47:41.989496 kernel: tsc: Detected 2299.999 MHz processor Apr 14 23:47:41.989502 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Apr 14 23:47:41.989516 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Apr 14 23:47:41.989529 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x10000000000 Apr 14 23:47:41.989541 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Apr 14 23:47:41.989552 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Apr 14 23:47:41.989564 kernel: e820: update [mem 0x48000000-0xffffffff] usable ==> reserved Apr 14 23:47:41.989575 kernel: last_pfn = 0x40000 max_arch_pfn = 0x10000000000 Apr 14 23:47:41.989583 kernel: Using GB pages for direct mapping Apr 14 23:47:41.989595 kernel: ACPI: Early table checksum verification disabled Apr 14 23:47:41.989609 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Apr 14 23:47:41.989622 kernel: ACPI: XSDT 0x000000003FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Apr 14 23:47:41.989633 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Apr 14 23:47:41.989643 kernel: ACPI: DSDT 0x000000003FFD6000 01E22B (v02 MSFTVM DSDT01 00000001 INTL 20230628) Apr 14 23:47:41.989652 kernel: ACPI: FACS 0x000000003FFFE000 000040 Apr 14 23:47:41.989664 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Apr 14 23:47:41.989678 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Apr 14 23:47:41.989688 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Apr 14 23:47:41.989699 kernel: ACPI: APIC 0x000000003FFD5000 000058 (v05 HVLITE HVLITETB 00000000 MSHV 00000000) Apr 14 23:47:41.989710 kernel: ACPI: SRAT 0x000000003FFD4000 0000A0 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) Apr 14 23:47:41.989718 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Apr 14 23:47:41.989726 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Apr 14 23:47:41.989735 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff422a] Apr 14 23:47:41.989749 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Apr 14 23:47:41.989759 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Apr 14 23:47:41.989769 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Apr 14 23:47:41.989777 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Apr 14 23:47:41.989788 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5057] Apr 14 23:47:41.989797 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd409f] Apr 14 23:47:41.989810 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Apr 14 23:47:41.989818 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Apr 14 23:47:41.989831 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] Apr 14 23:47:41.989841 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00001000-0x2bfffffff] Apr 14 23:47:41.989854 kernel: NODE_DATA(0) allocated [mem 0x2bfff8dc0-0x2bfffffff] Apr 14 23:47:41.989861 kernel: Zone ranges: Apr 14 23:47:41.989869 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Apr 14 23:47:41.989876 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Apr 14 23:47:41.989883 kernel: Normal [mem 0x0000000100000000-0x00000002bfffffff] Apr 14 23:47:41.989894 kernel: Device empty Apr 14 23:47:41.989904 kernel: Movable zone start for each node Apr 14 23:47:41.989913 kernel: Early memory node ranges Apr 14 23:47:41.989920 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Apr 14 23:47:41.989926 kernel: node 0: [mem 0x0000000000100000-0x00000000044fdfff] Apr 14 23:47:41.989932 kernel: node 0: [mem 0x00000000048fe000-0x000000003ff1efff] Apr 14 23:47:41.989940 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Apr 14 23:47:41.989951 kernel: node 0: [mem 0x0000000100000000-0x00000002bfffffff] Apr 14 23:47:41.989960 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff] Apr 14 23:47:41.989969 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Apr 14 23:47:41.989975 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Apr 14 23:47:41.989984 kernel: On node 0, zone DMA32: 1024 pages in unavailable ranges Apr 14 23:47:41.989990 kernel: On node 0, zone DMA32: 224 pages in unavailable ranges Apr 14 23:47:41.989997 kernel: ACPI: PM-Timer IO Port: 0x408 Apr 14 23:47:41.990005 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Apr 14 23:47:41.990013 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Apr 14 23:47:41.990020 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Apr 14 23:47:41.990027 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Apr 14 23:47:41.990034 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Apr 14 23:47:41.990041 kernel: TSC deadline timer available Apr 14 23:47:41.990050 kernel: CPU topo: Max. logical packages: 1 Apr 14 23:47:41.990057 kernel: CPU topo: Max. logical dies: 1 Apr 14 23:47:41.990068 kernel: CPU topo: Max. dies per package: 1 Apr 14 23:47:41.990079 kernel: CPU topo: Max. threads per core: 2 Apr 14 23:47:41.990088 kernel: CPU topo: Num. cores per package: 1 Apr 14 23:47:41.990101 kernel: CPU topo: Num. threads per package: 2 Apr 14 23:47:41.990108 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs Apr 14 23:47:41.990116 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Apr 14 23:47:41.990123 kernel: Booting paravirtualized kernel on Hyper-V Apr 14 23:47:41.990134 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Apr 14 23:47:41.990141 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Apr 14 23:47:41.990149 kernel: percpu: Embedded 60 pages/cpu s207960 r8192 d29608 u1048576 Apr 14 23:47:41.990164 kernel: pcpu-alloc: s207960 r8192 d29608 u1048576 alloc=1*2097152 Apr 14 23:47:41.990171 kernel: pcpu-alloc: [0] 0 1 Apr 14 23:47:41.990178 kernel: Hyper-V: PV spinlocks enabled Apr 14 23:47:41.990185 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Apr 14 23:47:41.990198 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=52685ba3ad3b9487d80aa4b833bfcf53bab81ab3d8190006a0e18c9734938056 Apr 14 23:47:41.990212 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Apr 14 23:47:41.990222 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 14 23:47:41.990229 kernel: Fallback order for Node 0: 0 Apr 14 23:47:41.990237 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2095807 Apr 14 23:47:41.990246 kernel: Policy zone: Normal Apr 14 23:47:41.990254 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 14 23:47:41.990264 kernel: software IO TLB: area num 2. Apr 14 23:47:41.990271 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Apr 14 23:47:41.990277 kernel: ftrace: allocating 40346 entries in 158 pages Apr 14 23:47:41.990284 kernel: ftrace: allocated 158 pages with 5 groups Apr 14 23:47:41.990294 kernel: Dynamic Preempt: voluntary Apr 14 23:47:41.990301 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 14 23:47:41.990310 kernel: rcu: RCU event tracing is enabled. Apr 14 23:47:41.990324 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Apr 14 23:47:41.990332 kernel: Trampoline variant of Tasks RCU enabled. Apr 14 23:47:41.990341 kernel: Rude variant of Tasks RCU enabled. Apr 14 23:47:41.990349 kernel: Tracing variant of Tasks RCU enabled. Apr 14 23:47:41.990359 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 14 23:47:41.990369 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Apr 14 23:47:41.990377 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Apr 14 23:47:41.990384 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Apr 14 23:47:41.990391 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Apr 14 23:47:41.990483 kernel: Using NULL legacy PIC Apr 14 23:47:41.990492 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0 Apr 14 23:47:41.990502 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 14 23:47:41.990509 kernel: Console: colour dummy device 80x25 Apr 14 23:47:41.990519 kernel: printk: legacy console [tty1] enabled Apr 14 23:47:41.990526 kernel: printk: legacy console [ttyS0] enabled Apr 14 23:47:41.990534 kernel: printk: legacy bootconsole [earlyser0] disabled Apr 14 23:47:41.990545 kernel: ACPI: Core revision 20240827 Apr 14 23:47:41.990555 kernel: Failed to register legacy timer interrupt Apr 14 23:47:41.990563 kernel: APIC: Switch to symmetric I/O mode setup Apr 14 23:47:41.990571 kernel: x2apic enabled Apr 14 23:47:41.990580 kernel: APIC: Switched APIC routing to: physical x2apic Apr 14 23:47:41.990588 kernel: Hyper-V: Host Build 10.0.26100.1536-1-0 Apr 14 23:47:41.990595 kernel: Hyper-V: enabling crash_kexec_post_notifiers Apr 14 23:47:41.990604 kernel: Hyper-V: Disabling IBT because of Hyper-V bug Apr 14 23:47:41.990612 kernel: Hyper-V: Using IPI hypercalls Apr 14 23:47:41.990620 kernel: APIC: send_IPI() replaced with hv_send_ipi() Apr 14 23:47:41.990628 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Apr 14 23:47:41.990637 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Apr 14 23:47:41.990645 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Apr 14 23:47:41.990654 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Apr 14 23:47:41.990662 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Apr 14 23:47:41.990670 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2127345424d, max_idle_ns: 440795318347 ns Apr 14 23:47:41.990681 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4599.99 BogoMIPS (lpj=2299999) Apr 14 23:47:41.990691 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Apr 14 23:47:41.990700 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Apr 14 23:47:41.990707 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Apr 14 23:47:41.990714 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Apr 14 23:47:41.990721 kernel: Spectre V2 : Mitigation: Retpolines Apr 14 23:47:41.990729 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Apr 14 23:47:41.990737 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Apr 14 23:47:41.990745 kernel: RETBleed: Vulnerable Apr 14 23:47:41.990753 kernel: Speculative Store Bypass: Vulnerable Apr 14 23:47:41.990760 kernel: active return thunk: its_return_thunk Apr 14 23:47:41.990767 kernel: ITS: Mitigation: Aligned branch/return thunks Apr 14 23:47:41.990775 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Apr 14 23:47:41.990782 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Apr 14 23:47:41.990790 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Apr 14 23:47:41.990798 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Apr 14 23:47:41.990806 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Apr 14 23:47:41.990814 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Apr 14 23:47:41.990821 kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' Apr 14 23:47:41.990828 kernel: x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' Apr 14 23:47:41.990836 kernel: x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' Apr 14 23:47:41.990843 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Apr 14 23:47:41.990851 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Apr 14 23:47:41.990859 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Apr 14 23:47:41.990867 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Apr 14 23:47:41.990874 kernel: x86/fpu: xstate_offset[11]: 2432, xstate_sizes[11]: 16 Apr 14 23:47:41.990882 kernel: x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 Apr 14 23:47:41.990890 kernel: x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 Apr 14 23:47:41.990897 kernel: x86/fpu: Enabled xstate features 0x608e7, context size is 10752 bytes, using 'compacted' format. Apr 14 23:47:41.990904 kernel: Freeing SMP alternatives memory: 32K Apr 14 23:47:41.990911 kernel: pid_max: default: 32768 minimum: 301 Apr 14 23:47:41.990918 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Apr 14 23:47:41.990925 kernel: landlock: Up and running. Apr 14 23:47:41.990934 kernel: SELinux: Initializing. Apr 14 23:47:41.990942 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Apr 14 23:47:41.990950 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Apr 14 23:47:41.990957 kernel: smpboot: CPU0: Intel INTEL(R) XEON(R) PLATINUM 8573C (family: 0x6, model: 0xcf, stepping: 0x2) Apr 14 23:47:41.990965 kernel: Performance Events: unsupported p6 CPU model 207 no PMU driver, software events only. Apr 14 23:47:41.990972 kernel: signal: max sigframe size: 11952 Apr 14 23:47:41.990980 kernel: rcu: Hierarchical SRCU implementation. Apr 14 23:47:41.990988 kernel: rcu: Max phase no-delay instances is 400. Apr 14 23:47:41.990996 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Apr 14 23:47:41.991008 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Apr 14 23:47:41.991016 kernel: smp: Bringing up secondary CPUs ... Apr 14 23:47:41.991023 kernel: smpboot: x86: Booting SMP configuration: Apr 14 23:47:41.991030 kernel: .... node #0, CPUs: #1 Apr 14 23:47:41.991038 kernel: smp: Brought up 1 node, 2 CPUs Apr 14 23:47:41.991045 kernel: smpboot: Total of 2 processors activated (9199.99 BogoMIPS) Apr 14 23:47:41.991056 kernel: Memory: 8058900K/8383228K available (14336K kernel code, 2458K rwdata, 31688K rodata, 15924K init, 2304K bss, 318100K reserved, 0K cma-reserved) Apr 14 23:47:41.991066 kernel: devtmpfs: initialized Apr 14 23:47:41.991074 kernel: x86/mm: Memory block size: 128MB Apr 14 23:47:41.991082 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Apr 14 23:47:41.991090 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 14 23:47:41.991097 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Apr 14 23:47:41.991105 kernel: pinctrl core: initialized pinctrl subsystem Apr 14 23:47:41.991113 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 14 23:47:41.991122 kernel: audit: initializing netlink subsys (disabled) Apr 14 23:47:41.991130 kernel: audit: type=2000 audit(1776210458.070:1): state=initialized audit_enabled=0 res=1 Apr 14 23:47:41.991138 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 14 23:47:41.991146 kernel: thermal_sys: Registered thermal governor 'user_space' Apr 14 23:47:41.991154 kernel: cpuidle: using governor menu Apr 14 23:47:41.991161 kernel: efi: Freeing EFI boot services memory: 34496K Apr 14 23:47:41.991169 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 14 23:47:41.991178 kernel: dca service started, version 1.12.1 Apr 14 23:47:41.991186 kernel: e820: reserve RAM buffer [mem 0x044fe000-0x07ffffff] Apr 14 23:47:41.991194 kernel: e820: reserve RAM buffer [mem 0x3ff1f000-0x3fffffff] Apr 14 23:47:41.991202 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Apr 14 23:47:41.991210 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 14 23:47:41.991217 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Apr 14 23:47:41.991225 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 14 23:47:41.991233 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Apr 14 23:47:41.991241 kernel: ACPI: Added _OSI(Module Device) Apr 14 23:47:41.991251 kernel: ACPI: Added _OSI(Processor Device) Apr 14 23:47:41.991260 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 14 23:47:41.991268 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 14 23:47:41.991275 kernel: ACPI: Interpreter enabled Apr 14 23:47:41.991282 kernel: ACPI: PM: (supports S0 S5) Apr 14 23:47:41.991291 kernel: ACPI: Using IOAPIC for interrupt routing Apr 14 23:47:41.991298 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Apr 14 23:47:41.991306 kernel: PCI: Ignoring E820 reservations for host bridge windows Apr 14 23:47:41.991315 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Apr 14 23:47:41.991322 kernel: iommu: Default domain type: Translated Apr 14 23:47:41.991330 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Apr 14 23:47:41.991338 kernel: efivars: Registered efivars operations Apr 14 23:47:41.991347 kernel: PCI: Using ACPI for IRQ routing Apr 14 23:47:41.991354 kernel: PCI: System does not support PCI Apr 14 23:47:41.991361 kernel: vgaarb: loaded Apr 14 23:47:41.991369 kernel: clocksource: Switched to clocksource tsc-early Apr 14 23:47:41.991378 kernel: VFS: Disk quotas dquot_6.6.0 Apr 14 23:47:41.991386 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 14 23:47:41.991394 kernel: pnp: PnP ACPI init Apr 14 23:47:41.993591 kernel: pnp: PnP ACPI: found 3 devices Apr 14 23:47:41.993646 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Apr 14 23:47:41.993654 kernel: NET: Registered PF_INET protocol family Apr 14 23:47:41.993716 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) Apr 14 23:47:41.993726 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) Apr 14 23:47:41.994558 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 14 23:47:41.994572 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 14 23:47:41.994581 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Apr 14 23:47:41.994587 kernel: TCP: Hash tables configured (established 65536 bind 65536) Apr 14 23:47:41.994593 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) Apr 14 23:47:41.994603 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) Apr 14 23:47:41.994613 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 14 23:47:41.994620 kernel: NET: Registered PF_XDP protocol family Apr 14 23:47:41.994626 kernel: PCI: CLS 0 bytes, default 64 Apr 14 23:47:41.994633 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Apr 14 23:47:41.994638 kernel: software IO TLB: mapped [mem 0x000000003a99d000-0x000000003e99d000] (64MB) Apr 14 23:47:41.994647 kernel: RAPL PMU: API unit is 2^-32 Joules, 1 fixed counters, 10737418240 ms ovfl timer Apr 14 23:47:41.994656 kernel: RAPL PMU: hw unit of domain psys 2^-0 Joules Apr 14 23:47:41.994663 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2127345424d, max_idle_ns: 440795318347 ns Apr 14 23:47:41.994668 kernel: clocksource: Switched to clocksource tsc Apr 14 23:47:41.994673 kernel: Initialise system trusted keyrings Apr 14 23:47:41.994681 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 Apr 14 23:47:41.994689 kernel: Key type asymmetric registered Apr 14 23:47:41.994698 kernel: Asymmetric key parser 'x509' registered Apr 14 23:47:41.994705 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Apr 14 23:47:41.994710 kernel: io scheduler mq-deadline registered Apr 14 23:47:41.994715 kernel: io scheduler kyber registered Apr 14 23:47:41.994721 kernel: io scheduler bfq registered Apr 14 23:47:41.994729 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Apr 14 23:47:41.994740 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 14 23:47:41.994747 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Apr 14 23:47:41.994752 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Apr 14 23:47:41.994757 kernel: serial8250: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A Apr 14 23:47:41.994763 kernel: i8042: PNP: No PS/2 controller found. Apr 14 23:47:41.994938 kernel: rtc_cmos 00:02: registered as rtc0 Apr 14 23:47:41.995047 kernel: rtc_cmos 00:02: setting system clock to 2026-04-14T23:47:39 UTC (1776210459) Apr 14 23:47:41.995145 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Apr 14 23:47:41.995155 kernel: intel_pstate: Intel P-state driver initializing Apr 14 23:47:41.995167 kernel: efifb: probing for efifb Apr 14 23:47:41.995175 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Apr 14 23:47:41.995183 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Apr 14 23:47:41.995193 kernel: efifb: scrolling: redraw Apr 14 23:47:41.995203 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Apr 14 23:47:41.995213 kernel: Console: switching to colour frame buffer device 128x48 Apr 14 23:47:41.995222 kernel: fb0: EFI VGA frame buffer device Apr 14 23:47:41.995232 kernel: pstore: Using crash dump compression: deflate Apr 14 23:47:41.995241 kernel: pstore: Registered efi_pstore as persistent store backend Apr 14 23:47:41.995250 kernel: NET: Registered PF_INET6 protocol family Apr 14 23:47:41.995258 kernel: Segment Routing with IPv6 Apr 14 23:47:41.995268 kernel: In-situ OAM (IOAM) with IPv6 Apr 14 23:47:41.995276 kernel: NET: Registered PF_PACKET protocol family Apr 14 23:47:41.995284 kernel: Key type dns_resolver registered Apr 14 23:47:41.995293 kernel: IPI shorthand broadcast: enabled Apr 14 23:47:41.995303 kernel: sched_clock: Marking stable (1725003663, 81336117)->(2094804330, -288464550) Apr 14 23:47:41.995312 kernel: registered taskstats version 1 Apr 14 23:47:41.995324 kernel: Loading compiled-in X.509 certificates Apr 14 23:47:41.995337 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.81-flatcar: 111a3c1c8768779d494368b24a58aab48270702c' Apr 14 23:47:41.995346 kernel: Demotion targets for Node 0: null Apr 14 23:47:41.995354 kernel: Key type .fscrypt registered Apr 14 23:47:41.995363 kernel: Key type fscrypt-provisioning registered Apr 14 23:47:41.995372 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 14 23:47:41.995381 kernel: ima: Allocated hash algorithm: sha1 Apr 14 23:47:41.995390 kernel: ima: No architecture policies found Apr 14 23:47:41.995415 kernel: clk: Disabling unused clocks Apr 14 23:47:41.995424 kernel: Freeing unused kernel image (initmem) memory: 15924K Apr 14 23:47:41.995433 kernel: Write protecting the kernel read-only data: 47104k Apr 14 23:47:41.995442 kernel: Freeing unused kernel image (rodata/data gap) memory: 1080K Apr 14 23:47:41.995450 kernel: Run /init as init process Apr 14 23:47:41.995458 kernel: with arguments: Apr 14 23:47:41.995466 kernel: /init Apr 14 23:47:41.995477 kernel: with environment: Apr 14 23:47:41.995485 kernel: HOME=/ Apr 14 23:47:41.995492 kernel: TERM=linux Apr 14 23:47:41.995502 kernel: hv_vmbus: Vmbus version:5.3 Apr 14 23:47:41.995511 kernel: pps_core: LinuxPPS API ver. 1 registered Apr 14 23:47:41.995520 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Apr 14 23:47:41.995529 kernel: PTP clock support registered Apr 14 23:47:41.995537 kernel: hv_utils: Registering HyperV Utility Driver Apr 14 23:47:41.995548 kernel: hv_vmbus: registering driver hv_utils Apr 14 23:47:41.995557 kernel: hv_utils: Shutdown IC version 3.2 Apr 14 23:47:41.995565 kernel: hv_utils: Heartbeat IC version 3.0 Apr 14 23:47:41.995574 kernel: hv_utils: TimeSync IC version 4.0 Apr 14 23:47:41.995582 kernel: SCSI subsystem initialized Apr 14 23:47:41.995590 kernel: hv_vmbus: registering driver hv_pci Apr 14 23:47:41.995762 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI VMBus probing: Using version 0x10004 Apr 14 23:47:41.995913 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI host bridge to bus c05b:00 Apr 14 23:47:41.996084 kernel: pci_bus c05b:00: root bus resource [mem 0xfc0000000-0xfc007ffff window] Apr 14 23:47:41.998481 kernel: pci_bus c05b:00: No busn resource found for root bus, will use [bus 00-ff] Apr 14 23:47:41.998671 kernel: pci c05b:00:00.0: [1414:00a9] type 00 class 0x010802 PCIe Endpoint Apr 14 23:47:41.998828 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit] Apr 14 23:47:41.998966 kernel: pci_bus c05b:00: busn_res: [bus 00-ff] end is updated to 00 Apr 14 23:47:41.999115 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit]: assigned Apr 14 23:47:41.999126 kernel: hv_vmbus: registering driver hv_storvsc Apr 14 23:47:41.999272 kernel: scsi host0: storvsc_host_t Apr 14 23:47:41.999439 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Apr 14 23:47:41.999456 kernel: hid: raw HID events driver (C) Jiri Kosina Apr 14 23:47:41.999466 kernel: hv_vmbus: registering driver hid_hyperv Apr 14 23:47:41.999477 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Apr 14 23:47:41.999610 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Apr 14 23:47:41.999623 kernel: hv_vmbus: registering driver hyperv_keyboard Apr 14 23:47:41.999633 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 Apr 14 23:47:41.999774 kernel: nvme nvme0: pci function c05b:00:00.0 Apr 14 23:47:41.999926 kernel: nvme c05b:00:00.0: enabling device (0000 -> 0002) Apr 14 23:47:42.000044 kernel: nvme nvme0: 2/0/0 default/read/poll queues Apr 14 23:47:42.000056 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 14 23:47:42.000202 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Apr 14 23:47:42.000216 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Apr 14 23:47:42.000359 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Apr 14 23:47:42.000369 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 14 23:47:42.000378 kernel: device-mapper: uevent: version 1.0.3 Apr 14 23:47:42.000387 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Apr 14 23:47:42.002168 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Apr 14 23:47:42.002232 kernel: raid6: avx512x4 gen() 45174 MB/s Apr 14 23:47:42.002367 kernel: raid6: avx512x2 gen() 45196 MB/s Apr 14 23:47:42.002376 kernel: raid6: avx512x1 gen() 30147 MB/s Apr 14 23:47:42.002384 kernel: raid6: avx2x4 gen() 41764 MB/s Apr 14 23:47:42.002450 kernel: raid6: avx2x2 gen() 43781 MB/s Apr 14 23:47:42.002507 kernel: raid6: avx2x1 gen() 32358 MB/s Apr 14 23:47:42.002561 kernel: raid6: using algorithm avx512x2 gen() 45196 MB/s Apr 14 23:47:42.002570 kernel: raid6: .... xor() 37501 MB/s, rmw enabled Apr 14 23:47:42.002623 kernel: raid6: using avx512x2 recovery algorithm Apr 14 23:47:42.002634 kernel: xor: automatically using best checksumming function avx Apr 14 23:47:42.002687 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 14 23:47:42.002696 kernel: BTRFS: device fsid 6665444f-e1dd-4874-9c79-f771bb369039 devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (964) Apr 14 23:47:42.002750 kernel: BTRFS info (device dm-0): first mount of filesystem 6665444f-e1dd-4874-9c79-f771bb369039 Apr 14 23:47:42.002759 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Apr 14 23:47:42.002812 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Apr 14 23:47:42.002821 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Apr 14 23:47:42.002878 kernel: BTRFS info (device dm-0 state E): enabling free space tree Apr 14 23:47:42.002886 kernel: loop: module loaded Apr 14 23:47:42.002940 kernel: loop0: detected capacity change from 0 to 106856 Apr 14 23:47:42.002948 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 14 23:47:42.003004 systemd[1]: /etc/systemd/system.conf.d/nocgroup.conf:2: Support for option DefaultCPUAccounting= has been removed and it is ignored Apr 14 23:47:42.003015 systemd[1]: /etc/systemd/system.conf.d/nocgroup.conf:5: Support for option DefaultBlockIOAccounting= has been removed and it is ignored Apr 14 23:47:42.003074 systemd[1]: Successfully made /usr/ read-only. Apr 14 23:47:42.003130 systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Apr 14 23:47:42.003138 systemd[1]: Detected virtualization microsoft. Apr 14 23:47:42.003193 systemd[1]: Detected architecture x86-64. Apr 14 23:47:42.003202 systemd[1]: Running in initrd. Apr 14 23:47:42.003256 systemd[1]: Initializing machine ID from random generator. Apr 14 23:47:42.003266 systemd[1]: No hostname configured, using default hostname. Apr 14 23:47:42.003321 systemd[1]: Hostname set to . Apr 14 23:47:42.003329 systemd[1]: Queued start job for default target initrd.target. Apr 14 23:47:42.003384 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Apr 14 23:47:42.003448 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 14 23:47:42.003457 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 14 23:47:42.003512 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 14 23:47:42.003521 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 14 23:47:42.003578 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 14 23:47:42.003634 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 14 23:47:42.003643 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 14 23:47:42.003707 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 14 23:47:42.003760 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Apr 14 23:47:42.003770 systemd[1]: Reached target paths.target - Path Units. Apr 14 23:47:42.003823 systemd[1]: Reached target slices.target - Slice Units. Apr 14 23:47:42.003832 systemd[1]: Reached target swap.target - Swaps. Apr 14 23:47:42.003888 systemd[1]: Reached target timers.target - Timer Units. Apr 14 23:47:42.003941 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 14 23:47:42.003951 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 14 23:47:42.004076 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Apr 14 23:47:42.004088 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 14 23:47:42.004100 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Apr 14 23:47:42.004109 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 14 23:47:42.004122 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 14 23:47:42.004132 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 14 23:47:42.004141 systemd[1]: Reached target sockets.target - Socket Units. Apr 14 23:47:42.004151 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 14 23:47:42.004161 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 14 23:47:42.004170 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 14 23:47:42.004180 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 14 23:47:42.004197 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Apr 14 23:47:42.004207 systemd[1]: Starting systemd-fsck-usr.service... Apr 14 23:47:42.004219 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 14 23:47:42.004233 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 14 23:47:42.004242 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 14 23:47:42.004252 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 14 23:47:42.004304 systemd-journald[1100]: Collecting audit messages is enabled. Apr 14 23:47:42.004332 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 14 23:47:42.004344 kernel: audit: type=1130 audit(1776210461.988: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' Apr 14 23:47:42.004355 systemd[1]: Finished systemd-fsck-usr.service. Apr 14 23:47:42.004367 kernel: audit: type=1130 audit(1776210461.999: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' Apr 14 23:47:42.004377 systemd-journald[1100]: Journal started Apr 14 23:47:42.004425 systemd-journald[1100]: Runtime Journal (/run/log/journal/6c060546fda3491daf16decbdf437d2c) is 8M, max 158.5M, 150.5M free. Apr 14 23:47:41.988000 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' Apr 14 23:47:41.999000 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' Apr 14 23:47:42.005000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:42.009511 kernel: audit: type=1130 audit(1776210462.005:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:42.009535 systemd[1]: Started systemd-journald.service - Journal Service. Apr 14 23:47:42.010000 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' Apr 14 23:47:42.015415 kernel: audit: type=1130 audit(1776210462.010:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:42.015617 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 14 23:47:42.023524 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 14 23:47:42.046421 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Apr 14 23:47:42.047620 systemd-tmpfiles[1112]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Apr 14 23:47:42.051076 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 14 23:47:42.054000 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' Apr 14 23:47:42.061016 kernel: Bridge firewalling registered Apr 14 23:47:42.056714 systemd-modules-load[1104]: Inserted module 'br_netfilter' Apr 14 23:47:42.061353 kernel: audit: type=1130 audit(1776210462.054:6): 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' Apr 14 23:47:42.056715 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 14 23:47:42.061000 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' Apr 14 23:47:42.062292 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 14 23:47:42.061000 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' Apr 14 23:47:42.070553 kernel: audit: type=1130 audit(1776210462.061:7): 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' Apr 14 23:47:42.070575 kernel: audit: type=1130 audit(1776210462.061:8): 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' Apr 14 23:47:42.071642 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 14 23:47:42.076368 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 14 23:47:42.085330 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 14 23:47:42.084000 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' Apr 14 23:47:42.089487 kernel: audit: type=1130 audit(1776210462.084:9): 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' Apr 14 23:47:42.102521 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 14 23:47:42.102000 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' Apr 14 23:47:42.108158 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 14 23:47:42.109849 kernel: audit: type=1130 audit(1776210462.102: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' Apr 14 23:47:42.111000 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' Apr 14 23:47:42.113201 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 14 23:47:42.124000 audit: BPF prog-id=5 op=LOAD Apr 14 23:47:42.126120 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 14 23:47:42.140558 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 14 23:47:42.144000 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' Apr 14 23:47:42.147511 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 14 23:47:42.172630 dracut-cmdline[1141]: dracut-109 Apr 14 23:47:42.174954 dracut-cmdline[1141]: 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=52685ba3ad3b9487d80aa4b833bfcf53bab81ab3d8190006a0e18c9734938056 Apr 14 23:47:42.206204 systemd-resolved[1129]: Positive Trust Anchors: Apr 14 23:47:42.206214 systemd-resolved[1129]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 14 23:47:42.206217 systemd-resolved[1129]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Apr 14 23:47:42.206254 systemd-resolved[1129]: 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 Apr 14 23:47:42.243811 systemd-resolved[1129]: Defaulting to hostname 'linux'. Apr 14 23:47:42.246389 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 14 23:47:42.247000 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' Apr 14 23:47:42.249053 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 14 23:47:42.285413 kernel: Loading iSCSI transport class v2.0-870. Apr 14 23:47:42.309495 kernel: iscsi: registered transport (tcp) Apr 14 23:47:42.340419 kernel: iscsi: registered transport (qla4xxx) Apr 14 23:47:42.340455 kernel: QLogic iSCSI HBA Driver Apr 14 23:47:42.364413 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Apr 14 23:47:42.380371 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Apr 14 23:47:42.382000 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' Apr 14 23:47:42.385300 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 14 23:47:42.415627 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 14 23:47:42.414000 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' Apr 14 23:47:42.416903 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 14 23:47:42.424518 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 14 23:47:42.443975 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 14 23:47:42.445000 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' Apr 14 23:47:42.446000 audit: BPF prog-id=6 op=LOAD Apr 14 23:47:42.446000 audit: BPF prog-id=7 op=LOAD Apr 14 23:47:42.448528 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 14 23:47:42.483036 systemd-udevd[1370]: Using default interface naming scheme 'v258'. Apr 14 23:47:42.501584 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 14 23:47:42.506189 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 14 23:47:42.504000 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' Apr 14 23:47:42.511000 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' Apr 14 23:47:42.514525 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 14 23:47:42.513000 audit: BPF prog-id=8 op=LOAD Apr 14 23:47:42.520546 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 14 23:47:42.543722 dracut-pre-trigger[1486]: rd.md=0: removing MD RAID activation Apr 14 23:47:42.566882 systemd-networkd[1487]: lo: Link UP Apr 14 23:47:42.566887 systemd-networkd[1487]: lo: Gained carrier Apr 14 23:47:42.570000 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' Apr 14 23:47:42.568669 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 14 23:47:42.574000 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' Apr 14 23:47:42.571636 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 14 23:47:42.575843 systemd[1]: Reached target network.target - Network. Apr 14 23:47:42.579544 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 14 23:47:42.641898 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 14 23:47:42.641000 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' Apr 14 23:47:42.643353 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 14 23:47:42.736696 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#108 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Apr 14 23:47:42.749562 kernel: hv_vmbus: registering driver hv_netvsc Apr 14 23:47:42.759434 kernel: cryptd: max_cpu_qlen set to 1000 Apr 14 23:47:42.771609 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 14 23:47:42.773000 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' Apr 14 23:47:42.778787 kernel: nvme nvme0: using unchecked data buffer Apr 14 23:47:42.771731 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 14 23:47:42.783898 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 14 23:47:42.788519 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 14 23:47:42.801849 systemd-networkd[1487]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Apr 14 23:47:42.801854 systemd-networkd[1487]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 14 23:47:42.803255 systemd-networkd[1487]: eth0: Link UP Apr 14 23:47:42.803383 systemd-networkd[1487]: eth0: Gained carrier Apr 14 23:47:42.803393 systemd-networkd[1487]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Apr 14 23:47:42.820177 kernel: AES CTR mode by8 optimization enabled Apr 14 23:47:42.820922 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 14 23:47:42.823611 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 14 23:47:42.827000 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' Apr 14 23:47:42.827000 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' Apr 14 23:47:42.835200 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 14 23:47:42.888310 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - MSFT NVMe Accelerator v1.0 EFI-SYSTEM. Apr 14 23:47:42.888000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:42.890325 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 14 23:47:42.906888 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - MSFT NVMe Accelerator v1.0 ROOT. Apr 14 23:47:42.915124 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - MSFT NVMe Accelerator v1.0 USR-A. Apr 14 23:47:42.920598 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 14 23:47:42.921000 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' Apr 14 23:47:42.935646 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Apr 14 23:47:42.935983 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 14 23:47:42.936081 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 14 23:47:42.949933 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 14 23:47:42.954710 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 14 23:47:42.961702 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 14 23:47:43.004552 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 14 23:47:43.007000 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' Apr 14 23:47:44.062127 disk-uuid[1676]: Warning: The kernel is still using the old partition table. Apr 14 23:47:44.062127 disk-uuid[1676]: The new table will be used at the next reboot or after you Apr 14 23:47:44.062127 disk-uuid[1676]: run partprobe(8) or kpartx(8) Apr 14 23:47:44.062127 disk-uuid[1676]: The operation has completed successfully. Apr 14 23:47:44.070889 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 14 23:47:44.073000 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' Apr 14 23:47:44.078670 kernel: kauditd_printk_skb: 21 callbacks suppressed Apr 14 23:47:44.071001 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 14 23:47:44.073000 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' Apr 14 23:47:44.085584 kernel: audit: type=1130 audit(1776210464.073: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' Apr 14 23:47:44.075533 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 14 23:47:44.089486 kernel: audit: type=1131 audit(1776210464.073:33): 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' Apr 14 23:47:44.111141 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1710) Apr 14 23:47:44.111182 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 296fde0d-a608-4429-9942-0fe994ba8601 Apr 14 23:47:44.112896 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Apr 14 23:47:44.133540 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 14 23:47:44.133576 kernel: BTRFS info (device nvme0n1p6): turning on async discard Apr 14 23:47:44.134566 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Apr 14 23:47:44.140417 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 296fde0d-a608-4429-9942-0fe994ba8601 Apr 14 23:47:44.141001 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 14 23:47:44.142000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:44.147436 kernel: audit: type=1130 audit(1776210464.142:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:44.147537 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 14 23:47:44.267525 systemd-networkd[1487]: eth0: Gained IPv6LL Apr 14 23:47:44.390778 ignition[1729]: Ignition 2.24.0 Apr 14 23:47:44.391612 ignition[1729]: Stage: fetch-offline Apr 14 23:47:44.395000 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' Apr 14 23:47:44.393159 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 14 23:47:44.391762 ignition[1729]: no configs at "/usr/lib/ignition/base.d" Apr 14 23:47:44.405728 kernel: audit: type=1130 audit(1776210464.395:35): 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' Apr 14 23:47:44.402534 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Apr 14 23:47:44.391769 ignition[1729]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Apr 14 23:47:44.391842 ignition[1729]: parsed url from cmdline: "" Apr 14 23:47:44.391845 ignition[1729]: no config URL provided Apr 14 23:47:44.391848 ignition[1729]: reading system config file "/usr/lib/ignition/user.ign" Apr 14 23:47:44.391852 ignition[1729]: no config at "/usr/lib/ignition/user.ign" Apr 14 23:47:44.391855 ignition[1729]: failed to fetch config: resource requires networking Apr 14 23:47:44.392265 ignition[1729]: Ignition finished successfully Apr 14 23:47:44.419299 ignition[1736]: Ignition 2.24.0 Apr 14 23:47:44.419306 ignition[1736]: Stage: fetch Apr 14 23:47:44.419494 ignition[1736]: no configs at "/usr/lib/ignition/base.d" Apr 14 23:47:44.419501 ignition[1736]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Apr 14 23:47:44.419561 ignition[1736]: parsed url from cmdline: "" Apr 14 23:47:44.419564 ignition[1736]: no config URL provided Apr 14 23:47:44.419568 ignition[1736]: reading system config file "/usr/lib/ignition/user.ign" Apr 14 23:47:44.419572 ignition[1736]: no config at "/usr/lib/ignition/user.ign" Apr 14 23:47:44.419590 ignition[1736]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Apr 14 23:47:44.419709 ignition[1736]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable Apr 14 23:47:44.620962 ignition[1736]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #2 Apr 14 23:47:44.621108 ignition[1736]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable Apr 14 23:47:45.021271 ignition[1736]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #3 Apr 14 23:47:45.021425 ignition[1736]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable Apr 14 23:47:45.029413 kernel: hv_netvsc f8615163-0000-1000-2000-0022489a4a66 eth0: VF slot 1 added Apr 14 23:47:45.821980 ignition[1736]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #4 Apr 14 23:47:45.822117 ignition[1736]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable Apr 14 23:47:46.033419 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 Apr 14 23:47:46.033654 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 Apr 14 23:47:46.036183 kernel: pci_bus 7870:00: root bus resource [mem 0xfc2000000-0xfc4007fff window] Apr 14 23:47:46.037689 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] Apr 14 23:47:46.042488 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint Apr 14 23:47:46.045508 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref] Apr 14 23:47:46.049535 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref] Apr 14 23:47:46.049603 kernel: pci 7870:00:00.0: enabling Extended Tags Apr 14 23:47:46.065880 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 Apr 14 23:47:46.066084 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref]: assigned Apr 14 23:47:46.071422 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref]: assigned Apr 14 23:47:46.078246 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) Apr 14 23:47:46.086412 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 Apr 14 23:47:46.090120 kernel: hv_netvsc f8615163-0000-1000-2000-0022489a4a66 eth0: VF registering: eth1 Apr 14 23:47:46.090285 kernel: mana 7870:00:00.0 eth1: joined to eth0 Apr 14 23:47:46.095241 systemd-networkd[1487]: eth1: Interface name change detected, renamed to enP30832s1. Apr 14 23:47:46.096849 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 Apr 14 23:47:46.198451 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Apr 14 23:47:46.201918 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Apr 14 23:47:46.202180 kernel: hv_netvsc f8615163-0000-1000-2000-0022489a4a66 eth0: Data path switched to VF: enP30832s1 Apr 14 23:47:46.202530 systemd-networkd[1487]: enP30832s1: Link UP Apr 14 23:47:46.203503 systemd-networkd[1487]: enP30832s1: Gained carrier Apr 14 23:47:47.422297 ignition[1736]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #5 Apr 14 23:47:47.422468 ignition[1736]: GET error: Get "http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text": dial tcp 169.254.169.254:80: connect: network is unreachable Apr 14 23:47:47.545450 systemd-networkd[1487]: eth0: DHCPv4 address 10.0.0.11/24, gateway 10.0.0.1 acquired from 168.63.129.16 Apr 14 23:47:50.625097 ignition[1736]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #6 Apr 14 23:47:50.684289 ignition[1736]: GET result: OK Apr 14 23:47:50.684331 ignition[1736]: config has been read from IMDS userdata Apr 14 23:47:50.684341 ignition[1736]: parsing config with SHA512: 716dfff8178c319c4ebad977a8cd7185470573fbb006047ec900d03219a4e9a054cfb55c24da857ea09e300c6b90b926387861e29005b86ef977b2d7e439b516 Apr 14 23:47:50.690563 unknown[1736]: fetched base config from "system" Apr 14 23:47:50.690573 unknown[1736]: fetched base config from "system" Apr 14 23:47:50.690735 ignition[1736]: fetch: fetch complete Apr 14 23:47:50.690578 unknown[1736]: fetched user config from "azure" Apr 14 23:47:50.690739 ignition[1736]: fetch: fetch passed Apr 14 23:47:50.690773 ignition[1736]: Ignition finished successfully Apr 14 23:47:50.696857 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Apr 14 23:47:50.699000 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' Apr 14 23:47:50.704628 kernel: audit: type=1130 audit(1776210470.699: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' Apr 14 23:47:50.702462 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 14 23:47:50.730257 ignition[1744]: Ignition 2.24.0 Apr 14 23:47:50.730266 ignition[1744]: Stage: kargs Apr 14 23:47:50.732519 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 14 23:47:50.736000 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' Apr 14 23:47:50.730528 ignition[1744]: no configs at "/usr/lib/ignition/base.d" Apr 14 23:47:50.745064 kernel: audit: type=1130 audit(1776210470.736:37): 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' Apr 14 23:47:50.741312 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 14 23:47:50.730535 ignition[1744]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Apr 14 23:47:50.730971 ignition[1744]: kargs: kargs passed Apr 14 23:47:50.730998 ignition[1744]: Ignition finished successfully Apr 14 23:47:50.762606 ignition[1750]: Ignition 2.24.0 Apr 14 23:47:50.762614 ignition[1750]: Stage: disks Apr 14 23:47:50.762802 ignition[1750]: no configs at "/usr/lib/ignition/base.d" Apr 14 23:47:50.762809 ignition[1750]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Apr 14 23:47:50.763464 ignition[1750]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Apr 14 23:47:50.771602 ignition[1750]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Apr 14 23:47:50.771672 ignition[1750]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/nvme0n1p9" Apr 14 23:47:50.771711 ignition[1750]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Apr 14 23:47:50.783879 ignition[1750]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Apr 14 23:47:50.783886 ignition[1750]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "3edc31dc-b694-4abb-86c9-1594f8223958" and label "ROOT" Apr 14 23:47:50.783888 ignition[1750]: disks: createFilesystems: filesystem at "/dev/disk/by-partlabel/ROOT" is already correctly formatted. Skipping mkfs... Apr 14 23:47:50.788000 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' Apr 14 23:47:50.804200 kernel: audit: type=1130 audit(1776210470.788: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' Apr 14 23:47:50.789232 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 14 23:47:50.783980 ignition[1750]: disks: disks passed Apr 14 23:47:50.794892 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 14 23:47:50.784021 ignition[1750]: Ignition finished successfully Apr 14 23:47:50.795125 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 14 23:47:50.795378 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 14 23:47:50.795408 systemd[1]: Reached target sysinit.target - System Initialization. Apr 14 23:47:50.795429 systemd[1]: Reached target basic.target - Basic System. Apr 14 23:47:50.796294 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 14 23:47:50.838680 systemd-fsck[1761]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Apr 14 23:47:50.842558 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 14 23:47:50.846000 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' Apr 14 23:47:50.850487 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 14 23:47:50.852083 kernel: audit: type=1130 audit(1776210470.846: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' Apr 14 23:47:51.011335 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 14 23:47:51.013975 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 14 23:47:51.019765 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 3edc31dc-b694-4abb-86c9-1594f8223958 r/w with ordered data mode. Quota mode: none. Apr 14 23:47:51.027911 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 14 23:47:51.032813 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 14 23:47:51.043517 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Apr 14 23:47:51.047765 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 14 23:47:51.047794 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 14 23:47:51.056728 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 14 23:47:51.061489 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1771) Apr 14 23:47:51.061507 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 296fde0d-a608-4429-9942-0fe994ba8601 Apr 14 23:47:51.061522 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Apr 14 23:47:51.062310 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 14 23:47:51.073682 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 14 23:47:51.073717 kernel: BTRFS info (device nvme0n1p6): turning on async discard Apr 14 23:47:51.073729 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Apr 14 23:47:51.076114 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 14 23:47:51.203716 coreos-metadata[1773]: Apr 14 23:47:51.203 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Apr 14 23:47:51.206893 coreos-metadata[1773]: Apr 14 23:47:51.206 INFO Fetch successful Apr 14 23:47:51.209449 coreos-metadata[1773]: Apr 14 23:47:51.208 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Apr 14 23:47:51.215937 coreos-metadata[1773]: Apr 14 23:47:51.215 INFO Fetch successful Apr 14 23:47:51.219497 coreos-metadata[1773]: Apr 14 23:47:51.216 INFO wrote hostname ci-4628.0.0-n-4166ffaadb to /sysroot/etc/hostname Apr 14 23:47:51.218551 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Apr 14 23:47:51.224000 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' Apr 14 23:47:51.230413 kernel: audit: type=1130 audit(1776210471.224:40): 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' Apr 14 23:47:51.454435 kernel: loop1: detected capacity change from 0 to 43200 Apr 14 23:47:51.463419 kernel: loop1: p1 p2 p3 Apr 14 23:47:51.565419 kernel: erofs: (device loop1p1): mounted with root inode @ nid 40. Apr 14 23:47:51.580417 kernel: loop2: detected capacity change from 0 to 43200 Apr 14 23:47:51.582413 kernel: loop2: p1 p2 p3 Apr 14 23:47:51.606427 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:51.606461 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Apr 14 23:47:51.608647 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Apr 14 23:47:51.609840 kernel: device-mapper: ioctl: error adding target to table Apr 14 23:47:51.610316 (sd-merge)[1874]: device-mapper: reload ioctl on 3bee206088b41e04d872e1d9a10773eca09ce87c1d91394f1943d2643bd33713-verity (254:1) failed: Invalid argument Apr 14 23:47:51.622433 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:51.693432 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Apr 14 23:47:51.693658 (sd-merge)[1874]: Using extensions '00-flatcar-default.raw'. Apr 14 23:47:51.694360 (sd-merge)[1874]: Merged extensions into '/sysroot/etc'. Apr 14 23:47:51.699351 initrd-setup-root[1882]: /etc 00-flatcar-default Tue 2026-04-14 23:47:42 UTC Apr 14 23:47:51.698000 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' Apr 14 23:47:51.707486 kernel: audit: type=1130 audit(1776210471.698: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' Apr 14 23:47:51.699904 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 14 23:47:51.704224 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 14 23:47:51.710506 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 14 23:47:51.723417 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 296fde0d-a608-4429-9942-0fe994ba8601 Apr 14 23:47:51.737616 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 14 23:47:51.740000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:51.746422 kernel: audit: type=1130 audit(1776210471.740:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:51.746717 ignition[1892]: INFO : Ignition 2.24.0 Apr 14 23:47:51.746717 ignition[1892]: INFO : Stage: mount Apr 14 23:47:51.753940 ignition[1892]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 14 23:47:51.753940 ignition[1892]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Apr 14 23:47:51.753940 ignition[1892]: INFO : mount: op(1): [started] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Apr 14 23:47:51.753940 ignition[1892]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "ext4" "/dev/disk/by-partlabel/ROOT" "/sysroot/tmp/_translate-filesystem-0-ign1" Apr 14 23:47:51.808973 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 14 23:47:51.850416 ignition[1892]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Apr 14 23:47:51.850416 ignition[1892]: INFO : mount: mount passed Apr 14 23:47:51.856484 ignition[1892]: INFO : Ignition finished successfully Apr 14 23:47:51.854898 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 14 23:47:51.858000 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' Apr 14 23:47:51.860612 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 14 23:47:51.868008 kernel: audit: type=1130 audit(1776210471.858:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:51.874278 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 14 23:47:51.888425 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1904) Apr 14 23:47:51.891415 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 296fde0d-a608-4429-9942-0fe994ba8601 Apr 14 23:47:51.891448 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Apr 14 23:47:51.898509 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 14 23:47:51.898542 kernel: BTRFS info (device nvme0n1p6): turning on async discard Apr 14 23:47:51.898663 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Apr 14 23:47:51.901293 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 14 23:47:51.922203 ignition[1921]: INFO : Ignition 2.24.0 Apr 14 23:47:51.922203 ignition[1921]: INFO : Stage: files Apr 14 23:47:51.925486 ignition[1921]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 14 23:47:51.925486 ignition[1921]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Apr 14 23:47:51.925486 ignition[1921]: DEBUG : files: compiled without relabeling support, skipping Apr 14 23:47:51.925486 ignition[1921]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 14 23:47:51.925486 ignition[1921]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: op(4): [started] processing unit "metadata.target" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: op(4): op(5): [started] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: op(4): op(5): [finished] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: op(4): [finished] processing unit "metadata.target" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: op(7): [started] setting preset to enabled for "coreos-metadata.service" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: op(7): [finished] setting preset to enabled for "coreos-metadata.service" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: op(8): [started] setting preset to enabled for "metadata.target" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: op(8): [finished] setting preset to enabled for "metadata.target" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: createResultFile: createFiles: op(9): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: createResultFile: createFiles: op(9): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 14 23:47:51.935526 ignition[1921]: INFO : files: files passed Apr 14 23:47:51.935526 ignition[1921]: INFO : Ignition finished successfully Apr 14 23:47:51.937000 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' Apr 14 23:47:51.962000 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' Apr 14 23:47:51.962000 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' Apr 14 23:47:51.926023 unknown[1921]: wrote ssh authorized keys file for user: core Apr 14 23:47:52.004380 kernel: audit: type=1130 audit(1776210471.937:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:51.934970 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 14 23:47:52.006069 kernel: audit: type=1130 audit(1776210471.962: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' Apr 14 23:47:51.939171 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 14 23:47:52.011501 kernel: loop3: detected capacity change from 0 to 43200 Apr 14 23:47:51.948513 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 14 23:47:52.013276 kernel: loop3: p1 p2 p3 Apr 14 23:47:52.013290 initrd-setup-root-after-ignition[1951]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 14 23:47:52.013290 initrd-setup-root-after-ignition[1951]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 14 23:47:51.961043 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 14 23:47:52.022476 kernel: erofs: (device loop3p1): mounted with root inode @ nid 40. Apr 14 23:47:52.022490 initrd-setup-root-after-ignition[1955]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 14 23:47:51.961125 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 14 23:47:52.027429 kernel: loop4: detected capacity change from 0 to 43200 Apr 14 23:47:52.029416 kernel: loop4: p1 p2 p3 Apr 14 23:47:52.047424 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:52.051682 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Apr 14 23:47:52.051711 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Apr 14 23:47:52.052835 kernel: device-mapper: ioctl: error adding target to table Apr 14 23:47:52.053335 (sd-merge)[1960]: device-mapper: reload ioctl on loop4p1-verity (254:2) failed: Invalid argument Apr 14 23:47:52.058421 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:52.095168 (sd-merge)[1960]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Apr 14 23:47:52.098490 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Apr 14 23:47:52.102425 kernel: device-mapper: ioctl: remove_all left 2 open device(s) Apr 14 23:47:52.104442 kernel: loop5: detected capacity change from 0 to 378016 Apr 14 23:47:52.124421 kernel: loop5: p1 p2 p3 Apr 14 23:47:52.257433 kernel: erofs: (device loop5p1): mounted with root inode @ nid 39. Apr 14 23:47:52.286415 kernel: loop4: detected capacity change from 0 to 177280 Apr 14 23:47:52.292584 kernel: loop4: p1 p2 p3 Apr 14 23:47:52.400420 kernel: erofs: (device loop4p1): mounted with root inode @ nid 39. Apr 14 23:47:52.423416 kernel: loop6: detected capacity change from 0 to 136864 Apr 14 23:47:52.433416 kernel: loop6: p1 p2 p3 Apr 14 23:47:52.542426 kernel: erofs: (device loop6p1): mounted with root inode @ nid 39. Apr 14 23:47:52.555413 kernel: loop7: detected capacity change from 0 to 378016 Apr 14 23:47:52.558430 kernel: loop7: p1 p2 p3 Apr 14 23:47:52.581609 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:52.581643 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Apr 14 23:47:52.583810 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Apr 14 23:47:52.585181 kernel: device-mapper: ioctl: error adding target to table Apr 14 23:47:52.585236 (sd-merge)[1973]: device-mapper: reload ioctl on 190a8e0e9c8882fd03b929e8e2843c135d4935c3bdd883ee175e47142369cce2-verity (254:2) failed: Invalid argument Apr 14 23:47:52.593424 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:52.684429 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Apr 14 23:47:52.691434 kernel: loop1: detected capacity change from 0 to 177280 Apr 14 23:47:52.693418 kernel: loop1: p1 p2 p3 Apr 14 23:47:52.706777 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:52.706808 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Apr 14 23:47:52.710322 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Apr 14 23:47:52.710350 kernel: device-mapper: ioctl: error adding target to table Apr 14 23:47:52.711371 (sd-merge)[1973]: device-mapper: reload ioctl on 80c5da7b8ee46949cfca63132104ad7a239607edd51860aa5fcd2d6cf384104f-verity (254:3) failed: Invalid argument Apr 14 23:47:52.717531 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:52.762417 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Apr 14 23:47:52.764415 kernel: loop3: detected capacity change from 0 to 136864 Apr 14 23:47:52.766427 kernel: loop3: p1 p2 p3 Apr 14 23:47:52.768471 kernel: loop3: p1 p2 p3 Apr 14 23:47:52.777567 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:52.777648 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Apr 14 23:47:52.778412 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Apr 14 23:47:52.780674 kernel: device-mapper: ioctl: error adding target to table Apr 14 23:47:52.780684 (sd-merge)[1973]: device-mapper: reload ioctl on fab7a2f3026978564ba58a22254d3a64fd01261f90a441de732fadd73bb71c7e-verity (254:4) failed: Invalid argument Apr 14 23:47:52.785417 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:52.818285 (sd-merge)[1973]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4628.0.0+nightly-20260414-2100.raw'. Apr 14 23:47:52.819189 (sd-merge)[1973]: Merged extensions into '/sysroot/usr'. Apr 14 23:47:52.825453 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Apr 14 23:47:52.822372 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 14 23:47:52.825000 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' Apr 14 23:47:52.826687 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 14 23:47:52.834001 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 14 23:47:52.861804 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 14 23:47:52.861905 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 14 23:47:52.863000 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' Apr 14 23:47:52.863000 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' Apr 14 23:47:52.864886 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Apr 14 23:47:52.865046 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 14 23:47:52.867623 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 14 23:47:52.880878 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 14 23:47:52.882506 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 14 23:47:52.899921 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 14 23:47:52.903509 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 14 23:47:52.900000 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' Apr 14 23:47:52.919263 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 14 23:47:52.919000 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' Apr 14 23:47:52.922000 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' Apr 14 23:47:52.924000 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' Apr 14 23:47:52.924000 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' Apr 14 23:47:52.925000 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' Apr 14 23:47:52.925000 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' Apr 14 23:47:52.919464 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 14 23:47:52.964457 ignition[2006]: INFO : Ignition 2.24.0 Apr 14 23:47:52.964457 ignition[2006]: INFO : Stage: umount Apr 14 23:47:52.964457 ignition[2006]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 14 23:47:52.964457 ignition[2006]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Apr 14 23:47:52.964457 ignition[2006]: INFO : umount: op(1): [started] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Apr 14 23:47:52.964457 ignition[2006]: INFO : umount: op(1): [finished] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Apr 14 23:47:52.964457 ignition[2006]: INFO : umount: umount passed Apr 14 23:47:52.964457 ignition[2006]: INFO : Ignition finished successfully Apr 14 23:47:52.967000 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' Apr 14 23:47:52.970000 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' Apr 14 23:47:52.970000 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' Apr 14 23:47:52.982000 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' Apr 14 23:47:52.987000 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' Apr 14 23:47:52.987000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:52.919665 systemd[1]: Stopped target timers.target - Timer Units. Apr 14 23:47:52.993000 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' Apr 14 23:47:52.920186 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 14 23:47:52.920286 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 14 23:47:52.920522 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 14 23:47:52.920764 systemd[1]: Stopped target basic.target - Basic System. Apr 14 23:47:52.921063 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 14 23:47:53.003000 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' Apr 14 23:47:52.921509 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 14 23:47:52.922000 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 14 23:47:52.922262 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Apr 14 23:47:52.922564 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 14 23:47:52.922855 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 14 23:47:52.923120 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 14 23:47:52.923430 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 14 23:47:52.923742 systemd[1]: Stopped target swap.target - Swaps. Apr 14 23:47:52.923956 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 14 23:47:52.924044 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 14 23:47:52.924356 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 14 23:47:52.924601 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 14 23:47:52.924818 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 14 23:47:52.925033 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 14 23:47:52.925205 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 14 23:47:52.925295 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 14 23:47:52.925914 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 14 23:47:52.926016 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 14 23:47:52.926437 systemd[1]: ignition-files.service: Deactivated successfully. Apr 14 23:47:52.926521 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 14 23:47:52.926745 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Apr 14 23:47:52.926832 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Apr 14 23:47:52.929603 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 14 23:47:52.934972 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 14 23:47:52.964143 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 14 23:47:52.964259 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 14 23:47:52.967618 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 14 23:47:52.967712 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 14 23:47:52.970649 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 14 23:47:52.970752 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 14 23:47:52.974817 systemd[1]: sysroot-tmp-_translate\x2dfilesystem\x2d0\x2dign1.mount: Deactivated successfully. Apr 14 23:47:52.977615 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 14 23:47:52.977711 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 14 23:47:52.985830 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 14 23:47:52.985936 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 14 23:47:52.988787 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 14 23:47:52.988823 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 14 23:47:52.989192 systemd[1]: ignition-fetch.service: Deactivated successfully. Apr 14 23:47:52.989213 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Apr 14 23:47:52.994742 systemd[1]: Stopped target network.target - Network. Apr 14 23:47:53.000768 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 14 23:47:53.000810 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 14 23:47:53.004336 systemd[1]: Stopped target paths.target - Path Units. Apr 14 23:47:53.008392 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 14 23:47:53.008681 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 14 23:47:53.013177 systemd[1]: Stopped target slices.target - Slice Units. Apr 14 23:47:53.018135 systemd[1]: Stopped target sockets.target - Socket Units. Apr 14 23:47:53.057842 systemd[1]: iscsid.socket: Deactivated successfully. Apr 14 23:47:53.057896 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 14 23:47:53.064333 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 14 23:47:53.064370 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 14 23:47:53.080453 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Apr 14 23:47:53.080487 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Apr 14 23:47:53.082782 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 14 23:47:53.083000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:53.082815 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 14 23:47:53.086000 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' Apr 14 23:47:53.084978 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 14 23:47:53.085006 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 14 23:47:53.093000 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' Apr 14 23:47:53.094000 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' Apr 14 23:47:53.087512 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 14 23:47:53.098000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:53.090018 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 14 23:47:53.101000 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' Apr 14 23:47:53.092312 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 14 23:47:53.092801 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 14 23:47:53.092879 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 14 23:47:53.095750 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 14 23:47:53.095829 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 14 23:47:53.099742 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 14 23:47:53.099845 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 14 23:47:53.105781 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 14 23:47:53.105861 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 14 23:47:53.117000 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' Apr 14 23:47:53.119000 audit: BPF prog-id=8 op=UNLOAD Apr 14 23:47:53.120000 audit: BPF prog-id=5 op=UNLOAD Apr 14 23:47:53.121551 systemd[1]: Stopped target network-pre.target - Preparation for Network. Apr 14 23:47:53.127467 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 14 23:47:53.127515 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 14 23:47:53.133504 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 14 23:47:53.134713 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 14 23:47:53.136000 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' Apr 14 23:47:53.139504 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 14 23:47:53.140371 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 14 23:47:53.140430 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 14 23:47:53.144000 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' Apr 14 23:47:53.144000 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' Apr 14 23:47:53.146000 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' Apr 14 23:47:53.145873 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 14 23:47:53.145910 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 14 23:47:53.146127 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 14 23:47:53.146148 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 14 23:47:53.146616 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 14 23:47:53.161866 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 14 23:47:53.161990 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 14 23:47:53.168000 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' Apr 14 23:47:53.170351 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 14 23:47:53.170668 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 14 23:47:53.178462 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 14 23:47:53.178500 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 14 23:47:53.179980 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 14 23:47:53.180007 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 14 23:47:53.180220 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 14 23:47:53.180240 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 14 23:47:53.178000 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' Apr 14 23:47:53.178000 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' Apr 14 23:47:53.178000 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' Apr 14 23:47:53.188413 kernel: hv_netvsc f8615163-0000-1000-2000-0022489a4a66 eth0: Data path switched from VF: enP30832s1 Apr 14 23:47:53.188638 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Apr 14 23:47:53.194099 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 14 23:47:53.197000 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' Apr 14 23:47:53.196037 systemd[1]: systemd-network-generator.service: Deactivated successfully. Apr 14 23:47:53.196079 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Apr 14 23:47:53.202000 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' Apr 14 23:47:53.203000 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' Apr 14 23:47:53.203000 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' Apr 14 23:47:53.203000 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' Apr 14 23:47:53.200156 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 14 23:47:53.200192 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 14 23:47:53.204194 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Apr 14 23:47:53.204224 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 14 23:47:53.204460 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 14 23:47:53.204482 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 14 23:47:53.204918 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 14 23:47:53.204940 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 14 23:47:53.205688 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 14 23:47:53.208486 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 14 23:47:53.230000 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' Apr 14 23:47:53.230789 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 14 23:47:53.232165 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 14 23:47:53.235000 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' Apr 14 23:47:53.235000 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' Apr 14 23:47:53.236828 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 14 23:47:53.241804 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 14 23:47:53.258026 systemd[1]: Switching root. Apr 14 23:47:53.295114 systemd-journald[1100]: Journal stopped Apr 14 23:47:55.753143 systemd-journald[1100]: Received SIGTERM from PID 1 (systemd). Apr 14 23:47:55.753180 kernel: SELinux: policy capability network_peer_controls=1 Apr 14 23:47:55.753195 kernel: SELinux: policy capability open_perms=1 Apr 14 23:47:55.753205 kernel: SELinux: policy capability extended_socket_class=1 Apr 14 23:47:55.753221 kernel: SELinux: policy capability always_check_network=0 Apr 14 23:47:55.753233 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 14 23:47:55.753245 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 14 23:47:55.753257 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 14 23:47:55.753267 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 14 23:47:55.753277 kernel: SELinux: policy capability userspace_initial_context=0 Apr 14 23:47:55.753290 systemd[1]: Successfully loaded SELinux policy in 71.236ms. Apr 14 23:47:55.753305 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 4.531ms. Apr 14 23:47:55.753316 systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Apr 14 23:47:55.753325 systemd[1]: Detected virtualization microsoft. Apr 14 23:47:55.753340 systemd[1]: Detected architecture x86-64. Apr 14 23:47:55.753348 systemd[1]: Detected first boot. Apr 14 23:47:55.753359 systemd[1]: Initializing machine ID from random generator. Apr 14 23:47:55.753372 systemd[1]: Hostname set to . Apr 14 23:47:55.753382 zram_generator::config[2054]: No configuration found. Apr 14 23:47:55.753422 kernel: Guest personality initialized and is inactive Apr 14 23:47:55.753433 kernel: VMCI host device registered (name=vmci, major=10, minor=259) Apr 14 23:47:55.753447 kernel: Initialized host personality Apr 14 23:47:55.753457 kernel: NET: Registered PF_VSOCK protocol family Apr 14 23:47:55.753472 systemd[1]: Applying preset policy. Apr 14 23:47:55.753484 systemd[1]: Created symlink '/etc/systemd/system/multi-user.target.wants/metadata.target' → '/etc/systemd/system/metadata.target'. Apr 14 23:47:55.753498 systemd[1]: Created symlink '/etc/systemd/system/afterburn.service' → '/usr/lib/systemd/system/coreos-metadata.service'. Apr 14 23:47:55.753511 systemd[1]: Created symlink '/etc/systemd/system/metadata.target.requires/coreos-metadata.service' → '/usr/lib/systemd/system/coreos-metadata.service'. Apr 14 23:47:55.753521 systemd[1]: Created symlink '/etc/systemd/system/timers.target.wants/google-oslogin-cache.timer' → '/usr/lib/systemd/system/google-oslogin-cache.timer'. Apr 14 23:47:55.753533 systemd[1]: Populated /etc with preset unit settings. Apr 14 23:47:55.753545 systemd[1]: /usr/lib/systemd/system/update-engine.service:10: Support for option BlockIOWeight= has been removed and it is ignored Apr 14 23:47:55.753555 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 14 23:47:55.753568 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 14 23:47:55.753579 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 14 23:47:55.753588 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 14 23:47:55.753597 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 14 23:47:55.753609 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 14 23:47:55.753623 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 14 23:47:55.753638 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 14 23:47:55.753651 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 14 23:47:55.753683 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 14 23:47:55.753700 systemd[1]: Created slice user.slice - User and Session Slice. Apr 14 23:47:55.753711 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 14 23:47:55.753720 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 14 23:47:55.753735 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 14 23:47:55.753747 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 14 23:47:55.753762 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 14 23:47:55.753773 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 14 23:47:55.753785 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Apr 14 23:47:55.753796 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Apr 14 23:47:55.753806 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 14 23:47:55.753820 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 14 23:47:55.753832 systemd[1]: Reached target imports.target - Image Downloads. Apr 14 23:47:55.753841 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 14 23:47:55.753855 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 14 23:47:55.753864 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 14 23:47:55.753883 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 14 23:47:55.753892 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 14 23:47:55.753902 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 14 23:47:55.753918 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Apr 14 23:47:55.753932 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Apr 14 23:47:55.753942 systemd[1]: Reached target slices.target - Slice Units. Apr 14 23:47:55.753953 systemd[1]: Reached target swap.target - Swaps. Apr 14 23:47:55.753963 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 14 23:47:55.753974 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Apr 14 23:47:55.753986 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 14 23:47:55.753996 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Apr 14 23:47:55.754006 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Apr 14 23:47:55.754018 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Apr 14 23:47:55.754030 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Apr 14 23:47:55.754041 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Service Varlink Socket. Apr 14 23:47:55.754050 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 14 23:47:55.754059 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Apr 14 23:47:55.754071 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Apr 14 23:47:55.754080 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Apr 14 23:47:55.754097 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Apr 14 23:47:55.754105 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 14 23:47:55.754117 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Apr 14 23:47:55.754128 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 14 23:47:55.754143 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 14 23:47:55.754152 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 14 23:47:55.754164 systemd[1]: Mounting media.mount - External Media Directory... Apr 14 23:47:55.754175 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 14 23:47:55.754184 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 14 23:47:55.754192 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 14 23:47:55.754202 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Apr 14 23:47:55.754215 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Apr 14 23:47:55.754228 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 14 23:47:55.754237 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Apr 14 23:47:55.754248 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Apr 14 23:47:55.754257 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 14 23:47:55.754266 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 14 23:47:55.754276 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 14 23:47:55.754286 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 14 23:47:55.754300 systemd[1]: modprobe@dm_mod.service - Load Kernel Module dm_mod was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!dm_mod). Apr 14 23:47:55.754310 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 14 23:47:55.754319 systemd[1]: modprobe@efi_pstore.service - Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). Apr 14 23:47:55.754328 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 14 23:47:55.754338 systemd[1]: modprobe@loop.service - Load Kernel Module loop was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!loop). Apr 14 23:47:55.754348 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 14 23:47:55.754358 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 14 23:47:55.754368 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 14 23:47:55.754377 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 14 23:47:55.754385 systemd[1]: Stopped systemd-fsck-usr.service. Apr 14 23:47:55.754395 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Apr 14 23:47:55.754789 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 14 23:47:55.754801 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 14 23:47:55.754811 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Apr 14 23:47:55.754822 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 14 23:47:55.754831 systemd[1]: Reached target time-set.target - System Time Set. Apr 14 23:47:55.754841 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 14 23:47:55.754850 kernel: fuse: init (API version 7.41) Apr 14 23:47:55.754859 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Apr 14 23:47:55.754872 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 14 23:47:55.754887 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 14 23:47:55.754898 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 14 23:47:55.754907 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 14 23:47:55.754918 systemd[1]: Mounted media.mount - External Media Directory. Apr 14 23:47:55.758369 systemd-journald[2148]: Collecting audit messages is enabled. Apr 14 23:47:55.758430 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 14 23:47:55.758446 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 14 23:47:55.758456 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 14 23:47:55.758467 kernel: kauditd_printk_skb: 72 callbacks suppressed Apr 14 23:47:55.758479 kernel: audit: type=1305 audit(1776210475.721:118): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Apr 14 23:47:55.758489 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 14 23:47:55.758499 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 14 23:47:55.758510 kernel: audit: type=1300 audit(1776210475.721:118): arch=c000003e syscall=46 success=yes exit=60 a0=4 a1=7ffdcb83cd20 a2=4000 a3=0 items=0 ppid=1 pid=2148 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) Apr 14 23:47:55.758519 kernel: ACPI: bus type drm_connector registered Apr 14 23:47:55.758529 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 14 23:47:55.758540 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 14 23:47:55.758550 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 14 23:47:55.758811 systemd-journald[2148]: Journal started Apr 14 23:47:55.758835 systemd-journald[2148]: Runtime Journal (/run/log/journal/d5838d5d8f334b6f97d0142b5483c2f7) is 8M, max 158.5M, 150.5M free. Apr 14 23:47:55.392000 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 Apr 14 23:47:55.606000 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' Apr 14 23:47:55.611000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:55.616000 audit: BPF prog-id=15 op=UNLOAD Apr 14 23:47:55.616000 audit: BPF prog-id=14 op=UNLOAD Apr 14 23:47:55.617000 audit: BPF prog-id=16 op=LOAD Apr 14 23:47:55.617000 audit: BPF prog-id=17 op=LOAD Apr 14 23:47:55.617000 audit: BPF prog-id=18 op=LOAD Apr 14 23:47:55.721000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Apr 14 23:47:55.721000 audit[2148]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=4 a1=7ffdcb83cd20 a2=4000 a3=0 items=0 ppid=1 pid=2148 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) Apr 14 23:47:55.225125 systemd[1]: Queued start job for default target multi-user.target. Apr 14 23:47:55.234195 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Apr 14 23:47:55.234472 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 14 23:47:55.721000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Apr 14 23:47:55.763870 kernel: audit: type=1327 audit(1776210475.721:118): proctitle="/usr/lib/systemd/systemd-journald" Apr 14 23:47:55.767630 systemd[1]: Started systemd-journald.service - Journal Service. Apr 14 23:47:55.730000 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' Apr 14 23:47:55.779891 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 14 23:47:55.786048 kernel: audit: type=1130 audit(1776210475.730:119): 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' Apr 14 23:47:55.780036 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 14 23:47:55.782784 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 14 23:47:55.786182 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Apr 14 23:47:55.754000 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' Apr 14 23:47:55.797497 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 14 23:47:55.808553 kernel: audit: type=1130 audit(1776210475.754:120): 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' Apr 14 23:47:55.800442 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 14 23:47:55.803408 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Apr 14 23:47:55.811367 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 14 23:47:55.754000 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' Apr 14 23:47:55.820431 kernel: audit: type=1131 audit(1776210475.754:121): 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' Apr 14 23:47:55.763000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:55.826672 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Apr 14 23:47:55.829103 kernel: audit: type=1130 audit(1776210475.763:122): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:55.829204 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 14 23:47:55.829232 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 14 23:47:55.832044 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Apr 14 23:47:55.763000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:55.777000 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' Apr 14 23:47:55.844391 kernel: audit: type=1131 audit(1776210475.763:123): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:55.844426 kernel: audit: type=1130 audit(1776210475.777:124): 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' Apr 14 23:47:55.781000 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' Apr 14 23:47:55.845529 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 14 23:47:55.848495 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Apr 14 23:47:55.849634 kernel: audit: type=1130 audit(1776210475.781:125): 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' Apr 14 23:47:55.781000 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' Apr 14 23:47:55.784000 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' Apr 14 23:47:55.787000 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' Apr 14 23:47:55.798000 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' Apr 14 23:47:55.801000 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' Apr 14 23:47:55.804000 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' Apr 14 23:47:55.863764 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 14 23:47:55.867576 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 14 23:47:55.870716 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 14 23:47:55.878140 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 14 23:47:55.882538 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 14 23:47:55.887700 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 14 23:47:55.901000 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' Apr 14 23:47:55.903565 systemd-journald[2148]: Time spent on flushing to /var/log/journal/d5838d5d8f334b6f97d0142b5483c2f7 is 34.401ms for 1211 entries. Apr 14 23:47:55.903565 systemd-journald[2148]: System Journal (/var/log/journal/d5838d5d8f334b6f97d0142b5483c2f7) is 8M, max 2.2G, 2.2G free. Apr 14 23:47:55.912000 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' Apr 14 23:47:55.932000 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' Apr 14 23:47:55.947000 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' Apr 14 23:47:55.896573 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Apr 14 23:47:55.957125 systemd-journald[2148]: Received client request to flush runtime journal. Apr 14 23:47:55.899885 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 14 23:47:55.957295 kernel: loop4: p1 p2 p3 Apr 14 23:47:55.911597 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 14 23:47:55.913335 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 14 23:47:55.923603 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Apr 14 23:47:55.931698 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 14 23:47:55.944950 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Apr 14 23:47:55.956988 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 14 23:47:55.959000 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' Apr 14 23:47:55.966280 kernel: erofs: (device loop4p1): mounted with root inode @ nid 40. Apr 14 23:47:55.987100 systemd-tmpfiles[2190]: ACLs are not supported, ignoring. Apr 14 23:47:55.987115 systemd-tmpfiles[2190]: ACLs are not supported, ignoring. Apr 14 23:47:55.990419 kernel: loop4: p1 p2 p3 Apr 14 23:47:55.992039 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 14 23:47:55.994000 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' Apr 14 23:47:55.998528 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 14 23:47:56.009656 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Apr 14 23:47:56.011000 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' Apr 14 23:47:56.049769 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:56.049824 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Apr 14 23:47:56.052215 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Apr 14 23:47:56.054152 kernel: device-mapper: ioctl: error adding target to table Apr 14 23:47:56.054217 (sd-merge)[2206]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument Apr 14 23:47:56.062357 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 14 23:47:56.064121 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:56.064000 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' Apr 14 23:47:56.064000 audit: BPF prog-id=19 op=LOAD Apr 14 23:47:56.064000 audit: BPF prog-id=20 op=LOAD Apr 14 23:47:56.064000 audit: BPF prog-id=21 op=LOAD Apr 14 23:47:56.066670 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Apr 14 23:47:56.067000 audit: BPF prog-id=22 op=LOAD Apr 14 23:47:56.070595 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 14 23:47:56.074545 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 14 23:47:56.082578 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Apr 14 23:47:56.088000 audit: BPF prog-id=23 op=LOAD Apr 14 23:47:56.088000 audit: BPF prog-id=24 op=LOAD Apr 14 23:47:56.088000 audit: BPF prog-id=25 op=LOAD Apr 14 23:47:56.092675 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 14 23:47:56.100361 systemd-tmpfiles[2217]: ACLs are not supported, ignoring. Apr 14 23:47:56.100444 systemd-tmpfiles[2217]: ACLs are not supported, ignoring. Apr 14 23:47:56.108106 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 14 23:47:56.109562 kernel: tun: Universal TUN/TAP device driver, 1.6 Apr 14 23:47:56.110629 systemd[1]: modprobe@tun.service: Deactivated successfully. Apr 14 23:47:56.108000 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' Apr 14 23:47:56.110977 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Apr 14 23:47:56.115000 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' Apr 14 23:47:56.115000 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' Apr 14 23:47:56.117000 audit: BPF prog-id=26 op=LOAD Apr 14 23:47:56.117000 audit: BPF prog-id=27 op=LOAD Apr 14 23:47:56.117000 audit: BPF prog-id=28 op=LOAD Apr 14 23:47:56.122522 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Apr 14 23:47:56.147580 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 14 23:47:56.148000 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' Apr 14 23:47:56.171001 systemd-nsresourced[2223]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Apr 14 23:47:56.172429 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Apr 14 23:47:56.173000 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' Apr 14 23:47:56.236847 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 14 23:47:56.238546 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 14 23:47:56.242539 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 14 23:47:56.259482 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 14 23:47:56.262951 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 14 23:47:56.263869 systemd-oomd[2215]: No swap; memory pressure usage will be degraded Apr 14 23:47:56.267641 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Apr 14 23:47:56.269000 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' Apr 14 23:47:56.293114 systemd-resolved[2216]: Positive Trust Anchors: Apr 14 23:47:56.293364 systemd-resolved[2216]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 14 23:47:56.293418 systemd-resolved[2216]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Apr 14 23:47:56.293484 systemd-resolved[2216]: 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 Apr 14 23:47:56.329103 systemd-resolved[2216]: Using system hostname 'ci-4628.0.0-n-4166ffaadb'. Apr 14 23:47:56.330223 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 14 23:47:56.331000 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' Apr 14 23:47:56.332599 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 14 23:47:56.418366 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 14 23:47:56.418000 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' Apr 14 23:47:56.418000 audit: BPF prog-id=29 op=LOAD Apr 14 23:47:56.418000 audit: BPF prog-id=30 op=LOAD Apr 14 23:47:56.420589 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 14 23:47:56.447757 systemd-udevd[2243]: Using default interface naming scheme 'v258'. Apr 14 23:47:56.525027 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 14 23:47:56.526000 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' Apr 14 23:47:56.527000 audit: BPF prog-id=31 op=LOAD Apr 14 23:47:56.532000 audit: BPF prog-id=7 op=UNLOAD Apr 14 23:47:56.532000 audit: BPF prog-id=6 op=UNLOAD Apr 14 23:47:56.531553 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 14 23:47:56.608700 systemd-networkd[2246]: lo: Link UP Apr 14 23:47:56.608710 systemd-networkd[2246]: lo: Gained carrier Apr 14 23:47:56.609768 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 14 23:47:56.612000 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' Apr 14 23:47:56.615163 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Apr 14 23:47:56.615207 systemd[1]: Reached target network.target - Network. Apr 14 23:47:56.617879 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Apr 14 23:47:56.621442 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 14 23:47:56.646626 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Apr 14 23:47:56.647000 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' Apr 14 23:47:56.698971 systemd-networkd[2246]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Apr 14 23:47:56.699881 systemd-networkd[2246]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 14 23:47:56.704419 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Apr 14 23:47:56.720337 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Apr 14 23:47:56.720608 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#89 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Apr 14 23:47:56.724683 kernel: hv_netvsc f8615163-0000-1000-2000-0022489a4a66 eth0: Data path switched to VF: enP30832s1 Apr 14 23:47:56.727062 systemd-networkd[2246]: enP30832s1: Link UP Apr 14 23:47:56.727550 systemd-networkd[2246]: eth0: Link UP Apr 14 23:47:56.727615 systemd-networkd[2246]: eth0: Gained carrier Apr 14 23:47:56.727657 systemd-networkd[2246]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Apr 14 23:47:56.731892 systemd-networkd[2246]: enP30832s1: Gained carrier Apr 14 23:47:56.743412 kernel: mousedev: PS/2 mouse device common for all mice Apr 14 23:47:56.748515 systemd-networkd[2246]: eth0: DHCPv4 address 10.0.0.11/24, gateway 10.0.0.1 acquired from 168.63.129.16 Apr 14 23:47:56.756421 kernel: hv_vmbus: registering driver hyperv_fb Apr 14 23:47:56.759417 kernel: hv_vmbus: registering driver hv_balloon Apr 14 23:47:56.766425 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Apr 14 23:47:56.772421 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Apr 14 23:47:56.776418 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Apr 14 23:47:56.779677 kernel: Console: switching to colour dummy device 80x25 Apr 14 23:47:56.786940 kernel: Console: switching to colour frame buffer device 128x48 Apr 14 23:47:56.890754 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Apr 14 23:47:56.931460 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 14 23:47:56.958189 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 14 23:47:56.959507 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 14 23:47:56.960000 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' Apr 14 23:47:56.960000 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' Apr 14 23:47:56.963520 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 14 23:47:57.001696 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Apr 14 23:47:57.004857 (sd-merge)[2206]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Apr 14 23:47:57.008000 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' Apr 14 23:47:57.007589 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Apr 14 23:47:57.013460 kernel: device-mapper: ioctl: remove_all left 5 open device(s) Apr 14 23:47:57.014601 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 14 23:47:57.023374 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Apr 14 23:47:57.032890 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 14 23:47:57.039947 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 14 23:47:57.041665 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 14 23:47:57.042000 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' Apr 14 23:47:57.042000 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' Apr 14 23:47:57.048557 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 14 23:47:57.057808 kernel: set_capacity_and_notify: 2 callbacks suppressed Apr 14 23:47:57.057857 kernel: loop4: detected capacity change from 0 to 136864 Apr 14 23:47:57.062441 kernel: loop4: p1 p2 p3 Apr 14 23:47:57.077417 kernel: erofs: (device loop4p1): mounted with root inode @ nid 39. Apr 14 23:47:57.093923 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 14 23:47:57.096000 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' Apr 14 23:47:57.097602 kernel: loop4: detected capacity change from 0 to 177280 Apr 14 23:47:57.098418 kernel: loop4: p1 p2 p3 Apr 14 23:47:57.111615 kernel: erofs: (device loop4p1): mounted with root inode @ nid 39. Apr 14 23:47:57.134416 kernel: loop4: detected capacity change from 0 to 378016 Apr 14 23:47:57.137418 kernel: loop4: p1 p2 p3 Apr 14 23:47:57.139430 kernel: loop4: p1 p2 p3 Apr 14 23:47:57.144415 kernel: kvm_intel: Using Hyper-V Enlightened VMCS Apr 14 23:47:57.156474 kernel: erofs: (device loop4p1): mounted with root inode @ nid 39. Apr 14 23:47:57.164732 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 14 23:47:57.168000 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' Apr 14 23:47:57.178424 kernel: loop4: detected capacity change from 0 to 136864 Apr 14 23:47:57.180443 kernel: loop4: p1 p2 p3 Apr 14 23:47:57.194548 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:57.194638 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Apr 14 23:47:57.194702 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Apr 14 23:47:57.195883 kernel: device-mapper: ioctl: error adding target to table Apr 14 23:47:57.195934 (sd-merge)[2347]: device-mapper: reload ioctl on loop4p1-verity (254:5) failed: Invalid argument Apr 14 23:47:57.198427 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:57.229907 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Apr 14 23:47:57.234203 kernel: loop5: detected capacity change from 0 to 177280 Apr 14 23:47:57.238528 kernel: loop5: p1 p2 p3 Apr 14 23:47:57.250714 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:57.250764 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Apr 14 23:47:57.252968 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Apr 14 23:47:57.254719 kernel: device-mapper: ioctl: error adding target to table Apr 14 23:47:57.254865 (sd-merge)[2347]: device-mapper: reload ioctl on loop5p1-verity (254:6) failed: Invalid argument Apr 14 23:47:57.257422 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:57.281417 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Apr 14 23:47:57.284462 kernel: loop6: detected capacity change from 0 to 378016 Apr 14 23:47:57.287005 kernel: loop6: p1 p2 p3 Apr 14 23:47:57.336041 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:57.341633 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Apr 14 23:47:57.341682 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Apr 14 23:47:57.342666 kernel: device-mapper: ioctl: error adding target to table Apr 14 23:47:57.342726 (sd-merge)[2347]: device-mapper: reload ioctl on loop6p1-verity (254:7) failed: Invalid argument Apr 14 23:47:57.345443 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 14 23:47:57.373416 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Apr 14 23:47:57.374104 (sd-merge)[2347]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Apr 14 23:47:57.375438 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 14 23:47:57.377000 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' Apr 14 23:47:57.379735 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 14 23:47:57.394429 kernel: device-mapper: ioctl: remove_all left 5 open device(s) Apr 14 23:47:57.396425 kernel: device-mapper: ioctl: remove_all left 5 open device(s) Apr 14 23:47:57.396522 systemd-tmpfiles[2370]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Apr 14 23:47:57.396752 systemd-tmpfiles[2370]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Apr 14 23:47:57.397138 systemd-tmpfiles[2370]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 14 23:47:57.399005 systemd-tmpfiles[2370]: ACLs are not supported, ignoring. Apr 14 23:47:57.399098 systemd-tmpfiles[2370]: ACLs are not supported, ignoring. Apr 14 23:47:57.409647 systemd-tmpfiles[2370]: Detected autofs mount point /boot during canonicalization of boot. Apr 14 23:47:57.409717 systemd-tmpfiles[2370]: Skipping /boot Apr 14 23:47:57.413051 systemd-tmpfiles[2370]: Detected autofs mount point /boot during canonicalization of boot. Apr 14 23:47:57.413108 systemd-tmpfiles[2370]: Skipping /boot Apr 14 23:47:57.419944 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 14 23:47:57.420000 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' Apr 14 23:47:57.423239 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 14 23:47:57.427539 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 14 23:47:57.431962 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 14 23:47:57.434927 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 14 23:47:57.440538 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 14 23:47:57.447000 audit[2380]: AUDIT1127 pid=2380 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' Apr 14 23:47:57.451320 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 14 23:47:57.452000 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' Apr 14 23:47:57.471996 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 14 23:47:57.472000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:47:57.539000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Apr 14 23:47:57.539000 audit[2402]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffe68a8f5a0 a2=420 a3=0 items=0 ppid=2376 pid=2402 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) Apr 14 23:47:57.539000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Apr 14 23:47:57.541393 augenrules[2402]: No rules Apr 14 23:47:57.543310 systemd[1]: audit-rules.service: Deactivated successfully. Apr 14 23:47:57.543584 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 14 23:47:57.581539 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 14 23:47:57.584603 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Apr 14 23:47:57.899533 systemd-networkd[2246]: eth0: Gained IPv6LL Apr 14 23:47:57.901088 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 14 23:47:57.902997 systemd[1]: Reached target network-online.target - Network is Online. Apr 14 23:47:58.966777 ldconfig[2378]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 14 23:47:58.978907 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 14 23:47:58.982492 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 14 23:47:58.994176 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 14 23:47:58.997624 systemd[1]: Reached target sysinit.target - System Initialization. Apr 14 23:47:58.999089 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 14 23:47:59.000641 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Apr 14 23:47:59.002124 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Apr 14 23:47:59.003912 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 14 23:47:59.006515 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 14 23:47:59.008196 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Apr 14 23:47:59.011505 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Apr 14 23:47:59.014468 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 14 23:47:59.016057 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 14 23:47:59.016084 systemd[1]: Reached target paths.target - Path Units. Apr 14 23:47:59.017198 systemd[1]: Reached target timers.target - Timer Units. Apr 14 23:47:59.019299 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 14 23:47:59.021682 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 14 23:47:59.024340 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Apr 14 23:47:59.028203 systemd[1]: Starting sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)... Apr 14 23:47:59.031993 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 14 23:47:59.034392 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Apr 14 23:47:59.036890 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Apr 14 23:47:59.040702 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Apr 14 23:47:59.043989 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 14 23:47:59.046499 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Apr 14 23:47:59.049071 systemd[1]: Reached target sockets.target - Socket Units. Apr 14 23:47:59.050550 systemd[1]: Reached target basic.target - Basic System. Apr 14 23:47:59.053483 systemd[1]: Reached target ssh-access.target - SSH Access Available. Apr 14 23:47:59.054714 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 14 23:47:59.054735 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 14 23:47:59.056163 systemd[1]: Starting chronyd.service - NTP client/server... Apr 14 23:47:59.058093 systemd[1]: Starting containerd.service - containerd container runtime... Apr 14 23:47:59.062496 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Apr 14 23:47:59.068113 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 14 23:47:59.073549 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 14 23:47:59.080532 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 14 23:47:59.085565 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 14 23:47:59.088495 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Apr 14 23:47:59.091584 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Apr 14 23:47:59.093522 systemd[1]: hv_fcopy_uio_daemon.service - Hyper-V FCOPY UIO daemon was skipped because of an unmet condition check (ConditionPathExists=/sys/bus/vmbus/devices/eb765408-105f-49b6-b4aa-c123b64d17d4/uio). Apr 14 23:47:59.095218 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Apr 14 23:47:59.097523 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Apr 14 23:47:59.098693 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 14 23:47:59.104671 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 14 23:47:59.109679 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 14 23:47:59.112944 jq[2426]: false Apr 14 23:47:59.113869 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 14 23:47:59.121748 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 14 23:47:59.124349 KVP[2429]: KVP starting; pid is:2429 Apr 14 23:47:59.124600 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 14 23:47:59.126186 systemd[1]: Starting update-engine.service - Update Engine... Apr 14 23:47:59.134744 KVP[2429]: KVP LIC Version: 3.1 Apr 14 23:47:59.136952 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 14 23:47:59.139243 kernel: hv_utils: KVP IC version 4.0 Apr 14 23:47:59.143143 google_oslogin_nss_cache[2428]: oslogin_cache_refresh[2428]: Refreshing passwd entry cache Apr 14 23:47:59.144340 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 14 23:47:59.146932 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 14 23:47:59.147124 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 14 23:47:59.148428 extend-filesystems[2427]: Found /dev/nvme0n1p6 Apr 14 23:47:59.148248 oslogin_cache_refresh[2428]: Refreshing passwd entry cache Apr 14 23:47:59.150769 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 14 23:47:59.153587 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 14 23:47:59.161939 chronyd[2418]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Apr 14 23:47:59.163237 extend-filesystems[2427]: Found /dev/nvme0n1p9 Apr 14 23:47:59.171825 extend-filesystems[2427]: Checking size of /dev/nvme0n1p9 Apr 14 23:47:59.171307 chronyd[2418]: Timezone right/UTC failed leap second check, ignoring Apr 14 23:47:59.171623 chronyd[2418]: Loaded seccomp filter (level 2) Apr 14 23:47:59.174110 systemd[1]: Started chronyd.service - NTP client/server. Apr 14 23:47:59.177344 oslogin_cache_refresh[2428]: Failure getting users, quitting Apr 14 23:47:59.177856 google_oslogin_nss_cache[2428]: oslogin_cache_refresh[2428]: Failure getting users, quitting Apr 14 23:47:59.177856 google_oslogin_nss_cache[2428]: oslogin_cache_refresh[2428]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Apr 14 23:47:59.177856 google_oslogin_nss_cache[2428]: oslogin_cache_refresh[2428]: Refreshing group entry cache Apr 14 23:47:59.177358 oslogin_cache_refresh[2428]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Apr 14 23:47:59.177417 oslogin_cache_refresh[2428]: Refreshing group entry cache Apr 14 23:47:59.181581 jq[2439]: true Apr 14 23:47:59.199500 oslogin_cache_refresh[2428]: Failure getting groups, quitting Apr 14 23:47:59.200108 google_oslogin_nss_cache[2428]: oslogin_cache_refresh[2428]: Failure getting groups, quitting Apr 14 23:47:59.200108 google_oslogin_nss_cache[2428]: oslogin_cache_refresh[2428]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Apr 14 23:47:59.200144 update_engine[2438]: I20260414 23:47:59.198844 2438 main.cc:92] Flatcar Update Engine starting Apr 14 23:47:59.199508 oslogin_cache_refresh[2428]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Apr 14 23:47:59.202456 extend-filesystems[2427]: Resized partition /dev/nvme0n1p9 Apr 14 23:47:59.204156 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 14 23:47:59.206451 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Apr 14 23:47:59.206636 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Apr 14 23:47:59.209380 systemd[1]: motdgen.service: Deactivated successfully. Apr 14 23:47:59.209588 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 14 23:47:59.215764 jq[2469]: true Apr 14 23:47:59.220395 extend-filesystems[2481]: resize2fs 1.47.3 (8-Jul-2025) Apr 14 23:47:59.228849 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 6359552 to 6376955 blocks Apr 14 23:47:59.228887 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 6376955 Apr 14 23:47:59.249282 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 14 23:47:59.249095 dbus-daemon[2421]: [system] SELinux support is enabled Apr 14 23:47:59.259663 extend-filesystems[2481]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Apr 14 23:47:59.259663 extend-filesystems[2481]: old_desc_blocks = 4, new_desc_blocks = 4 Apr 14 23:47:59.259663 extend-filesystems[2481]: The filesystem on /dev/nvme0n1p9 is now 6376955 (4k) blocks long. Apr 14 23:47:59.273535 extend-filesystems[2427]: Resized filesystem in /dev/nvme0n1p9 Apr 14 23:47:59.276501 update_engine[2438]: I20260414 23:47:59.268299 2438 update_check_scheduler.cc:74] Next update check in 3m30s Apr 14 23:47:59.266781 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 14 23:47:59.266969 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 14 23:47:59.276378 systemd[1]: Started update-engine.service - Update Engine. Apr 14 23:47:59.280856 systemd-logind[2437]: New seat seat0. Apr 14 23:47:59.282094 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Apr 14 23:47:59.282114 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 14 23:47:59.284648 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Apr 14 23:47:59.284667 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 14 23:47:59.288727 systemd-logind[2437]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Apr 14 23:47:59.313284 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 14 23:47:59.318766 systemd[1]: Started systemd-logind.service - User Login Management. Apr 14 23:47:59.350970 coreos-metadata[2420]: Apr 14 23:47:59.350 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Apr 14 23:47:59.360441 coreos-metadata[2420]: Apr 14 23:47:59.360 INFO Fetch successful Apr 14 23:47:59.360441 coreos-metadata[2420]: Apr 14 23:47:59.360 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Apr 14 23:47:59.364987 coreos-metadata[2420]: Apr 14 23:47:59.363 INFO Fetch successful Apr 14 23:47:59.364987 coreos-metadata[2420]: Apr 14 23:47:59.363 INFO Fetching http://168.63.129.16/machine/82889a92-9c93-48fa-9767-1c9c4a08303c/0bc4acb4%2D19b4%2D4d8f%2Db92d%2D914f98b61158.%5Fci%2D4628.0.0%2Dn%2D4166ffaadb?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Apr 14 23:47:59.364987 coreos-metadata[2420]: Apr 14 23:47:59.364 INFO Fetch successful Apr 14 23:47:59.364987 coreos-metadata[2420]: Apr 14 23:47:59.364 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Apr 14 23:47:59.365988 bash[2503]: Updated "/home/core/.ssh/authorized_keys" Apr 14 23:47:59.368832 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 14 23:47:59.373089 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Apr 14 23:47:59.378382 coreos-metadata[2420]: Apr 14 23:47:59.378 INFO Fetch successful Apr 14 23:47:59.458749 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Apr 14 23:47:59.462814 systemd[1]: Reached target metadata.target. Apr 14 23:47:59.469453 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 14 23:47:59.515587 locksmithd[2500]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 14 23:47:59.530009 sshd_keygen[2470]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 14 23:47:59.548953 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 14 23:47:59.552873 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 14 23:47:59.556075 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Apr 14 23:47:59.564900 systemd[1]: issuegen.service: Deactivated successfully. Apr 14 23:47:59.565153 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 14 23:47:59.571636 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 14 23:47:59.583844 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 14 23:47:59.590041 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 14 23:47:59.593371 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Apr 14 23:47:59.595719 systemd[1]: Reached target getty.target - Login Prompts. Apr 14 23:47:59.600351 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Apr 14 23:47:59.770096 containerd[2461]: time="2026-04-14T23:47:59Z" 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 Apr 14 23:47:59.771279 containerd[2461]: time="2026-04-14T23:47:59.771241065Z" level=info msg="starting containerd" revision=1c4457e00facac03ce1d75f7b6777a7a851e5c41 version=v2.2.0 Apr 14 23:47:59.781420 containerd[2461]: time="2026-04-14T23:47:59.781319476Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="13.931µs" Apr 14 23:47:59.781475 containerd[2461]: time="2026-04-14T23:47:59.781393016Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Apr 14 23:47:59.781510 containerd[2461]: time="2026-04-14T23:47:59.781496926Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Apr 14 23:47:59.781528 containerd[2461]: time="2026-04-14T23:47:59.781515535Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Apr 14 23:47:59.781648 containerd[2461]: time="2026-04-14T23:47:59.781632445Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Apr 14 23:47:59.781675 containerd[2461]: time="2026-04-14T23:47:59.781652959Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Apr 14 23:47:59.781675 containerd[2461]: time="2026-04-14T23:47:59.781667716Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Apr 14 23:47:59.781723 containerd[2461]: time="2026-04-14T23:47:59.781712775Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Apr 14 23:47:59.781742 containerd[2461]: time="2026-04-14T23:47:59.781725429Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Apr 14 23:47:59.781907 containerd[2461]: time="2026-04-14T23:47:59.781892922Z" 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 Apr 14 23:47:59.781928 containerd[2461]: time="2026-04-14T23:47:59.781908446Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Apr 14 23:47:59.781949 containerd[2461]: time="2026-04-14T23:47:59.781922145Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Apr 14 23:47:59.781949 containerd[2461]: time="2026-04-14T23:47:59.781933002Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Apr 14 23:47:59.782106 containerd[2461]: time="2026-04-14T23:47:59.782094157Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Apr 14 23:47:59.782159 containerd[2461]: time="2026-04-14T23:47:59.782149582Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Apr 14 23:47:59.782286 containerd[2461]: time="2026-04-14T23:47:59.782275305Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Apr 14 23:47:59.782314 containerd[2461]: time="2026-04-14T23:47:59.782303062Z" 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 Apr 14 23:47:59.782332 containerd[2461]: time="2026-04-14T23:47:59.782316645Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Apr 14 23:47:59.782349 containerd[2461]: time="2026-04-14T23:47:59.782336506Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Apr 14 23:47:59.783290 containerd[2461]: time="2026-04-14T23:47:59.783181001Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Apr 14 23:47:59.783290 containerd[2461]: time="2026-04-14T23:47:59.783259432Z" level=info msg="metadata content store policy set" policy=shared Apr 14 23:47:59.797729 containerd[2461]: time="2026-04-14T23:47:59.797704814Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Apr 14 23:47:59.797800 containerd[2461]: time="2026-04-14T23:47:59.797749043Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Apr 14 23:47:59.797800 containerd[2461]: time="2026-04-14T23:47:59.797773521Z" level=info msg="built-in NRI default validator is disabled" Apr 14 23:47:59.797800 containerd[2461]: time="2026-04-14T23:47:59.797779837Z" level=info msg="runtime interface created" Apr 14 23:47:59.797800 containerd[2461]: time="2026-04-14T23:47:59.797783833Z" level=info msg="created NRI interface" Apr 14 23:47:59.797800 containerd[2461]: time="2026-04-14T23:47:59.797791282Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Apr 14 23:47:59.797951 containerd[2461]: time="2026-04-14T23:47:59.797844096Z" level=info msg="skip loading plugin" error="failed to check mkfs.erofs availability: failed to run mkfs.erofs --help: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Apr 14 23:47:59.797951 containerd[2461]: time="2026-04-14T23:47:59.797854398Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Apr 14 23:47:59.797951 containerd[2461]: time="2026-04-14T23:47:59.797866342Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Apr 14 23:47:59.797951 containerd[2461]: time="2026-04-14T23:47:59.797885055Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Apr 14 23:47:59.798032 containerd[2461]: time="2026-04-14T23:47:59.797986814Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Apr 14 23:47:59.798032 containerd[2461]: time="2026-04-14T23:47:59.798003572Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Apr 14 23:47:59.798032 containerd[2461]: time="2026-04-14T23:47:59.798016704Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Apr 14 23:47:59.798032 containerd[2461]: time="2026-04-14T23:47:59.798027466Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Apr 14 23:47:59.798110 containerd[2461]: time="2026-04-14T23:47:59.798038580Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Apr 14 23:47:59.798110 containerd[2461]: time="2026-04-14T23:47:59.798048185Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Apr 14 23:47:59.798110 containerd[2461]: time="2026-04-14T23:47:59.798059316Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Apr 14 23:47:59.798110 containerd[2461]: time="2026-04-14T23:47:59.798067245Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Apr 14 23:47:59.798110 containerd[2461]: time="2026-04-14T23:47:59.798077181Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Apr 14 23:47:59.798204 containerd[2461]: time="2026-04-14T23:47:59.798154398Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Apr 14 23:47:59.798204 containerd[2461]: time="2026-04-14T23:47:59.798168812Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Apr 14 23:47:59.798204 containerd[2461]: time="2026-04-14T23:47:59.798178715Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Apr 14 23:47:59.798204 containerd[2461]: time="2026-04-14T23:47:59.798189114Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Apr 14 23:47:59.798204 containerd[2461]: time="2026-04-14T23:47:59.798201515Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Apr 14 23:47:59.798295 containerd[2461]: time="2026-04-14T23:47:59.798211802Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Apr 14 23:47:59.798295 containerd[2461]: time="2026-04-14T23:47:59.798221808Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Apr 14 23:47:59.798295 containerd[2461]: time="2026-04-14T23:47:59.798230844Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Apr 14 23:47:59.798295 containerd[2461]: time="2026-04-14T23:47:59.798242493Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Apr 14 23:47:59.798295 containerd[2461]: time="2026-04-14T23:47:59.798251701Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Apr 14 23:47:59.798295 containerd[2461]: time="2026-04-14T23:47:59.798262178Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Apr 14 23:47:59.798295 containerd[2461]: time="2026-04-14T23:47:59.798270471Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Apr 14 23:47:59.798440 containerd[2461]: time="2026-04-14T23:47:59.798368638Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Apr 14 23:47:59.798470 containerd[2461]: time="2026-04-14T23:47:59.798419146Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Apr 14 23:47:59.798470 containerd[2461]: time="2026-04-14T23:47:59.798463655Z" level=info msg="Start snapshots syncer" Apr 14 23:47:59.798671 containerd[2461]: time="2026-04-14T23:47:59.798640301Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Apr 14 23:47:59.798923 containerd[2461]: time="2026-04-14T23:47:59.798896242Z" 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\"}" Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.798936296Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.799229851Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.799363913Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.799387333Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.799417455Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.799427478Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.799437817Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.799448339Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.799457434Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.799469628Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Apr 14 23:47:59.799602 containerd[2461]: time="2026-04-14T23:47:59.799478464Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Apr 14 23:47:59.800127 containerd[2461]: time="2026-04-14T23:47:59.800030852Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Apr 14 23:47:59.800127 containerd[2461]: time="2026-04-14T23:47:59.800064485Z" 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 Apr 14 23:47:59.800127 containerd[2461]: time="2026-04-14T23:47:59.800074002Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Apr 14 23:47:59.800127 containerd[2461]: time="2026-04-14T23:47:59.800083150Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Apr 14 23:47:59.800127 containerd[2461]: time="2026-04-14T23:47:59.800090717Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Apr 14 23:47:59.800127 containerd[2461]: time="2026-04-14T23:47:59.800100312Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Apr 14 23:47:59.800127 containerd[2461]: time="2026-04-14T23:47:59.800111123Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Apr 14 23:47:59.800265 containerd[2461]: time="2026-04-14T23:47:59.800258150Z" level=info msg="Connect containerd service" Apr 14 23:47:59.800315 containerd[2461]: time="2026-04-14T23:47:59.800308873Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 14 23:47:59.801096 containerd[2461]: time="2026-04-14T23:47:59.801062557Z" 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" Apr 14 23:48:00.015786 containerd[2461]: time="2026-04-14T23:48:00.015763930Z" level=info msg="Start subscribing containerd event" Apr 14 23:48:00.016147 containerd[2461]: time="2026-04-14T23:48:00.015840852Z" level=info msg="Start recovering state" Apr 14 23:48:00.016147 containerd[2461]: time="2026-04-14T23:48:00.015911433Z" level=info msg="Start event monitor" Apr 14 23:48:00.016147 containerd[2461]: time="2026-04-14T23:48:00.015918539Z" level=info msg="Start cni network conf syncer for default" Apr 14 23:48:00.016147 containerd[2461]: time="2026-04-14T23:48:00.015923055Z" level=info msg="Start streaming server" Apr 14 23:48:00.016147 containerd[2461]: time="2026-04-14T23:48:00.015929979Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Apr 14 23:48:00.016147 containerd[2461]: time="2026-04-14T23:48:00.015941991Z" level=info msg="runtime interface starting up..." Apr 14 23:48:00.016147 containerd[2461]: time="2026-04-14T23:48:00.015945917Z" level=info msg="starting plugins..." Apr 14 23:48:00.016147 containerd[2461]: time="2026-04-14T23:48:00.015953909Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Apr 14 23:48:00.016301 containerd[2461]: time="2026-04-14T23:48:00.016215613Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 14 23:48:00.016301 containerd[2461]: time="2026-04-14T23:48:00.016254351Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 14 23:48:00.016938 systemd[1]: Started containerd.service - containerd container runtime. Apr 14 23:48:00.019373 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 14 23:48:00.028459 systemd[1]: Startup finished in 2.861s (kernel) + 12.570s (initrd) + 6.589s (userspace) = 22.021s. Apr 14 23:48:00.032508 containerd[2461]: time="2026-04-14T23:48:00.032483174Z" level=info msg="containerd successfully booted in 0.262582s" Apr 14 23:48:00.484280 login[2549]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Apr 14 23:48:00.489035 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 14 23:48:00.490082 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 14 23:48:00.492148 systemd-logind[2437]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Apr 14 23:48:00.513280 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 14 23:48:00.519584 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 14 23:48:00.720706 login[2550]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Apr 14 23:48:00.728488 systemd-logind[2437]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Apr 14 23:48:00.729627 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 14 23:48:00.746738 waagent[2551]: 2026-04-14T23:48:00.746659Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.746912Z INFO Daemon Daemon OS: flatcar 4628.0.0 Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.747165Z INFO Daemon Daemon Python: 3.12.12 Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.748228Z INFO Daemon Daemon Run daemon Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.748825Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4628.0.0' Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.749024Z INFO Daemon Daemon Using waagent for provisioning Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.749415Z INFO Daemon Daemon Activate resource disk Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.749580Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.750964Z INFO Daemon Daemon Found device: None Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.752355Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.752629Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.753465Z INFO Daemon Daemon Clean protocol and wireserver endpoint Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.753578Z INFO Daemon Daemon Running default provisioning handler Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.759366Z 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. Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.759840Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.759934Z INFO Daemon Daemon cloud-init is enabled: False Apr 14 23:48:00.769568 waagent[2551]: 2026-04-14T23:48:00.760213Z INFO Daemon Daemon Copying ovf-env.xml Apr 14 23:48:00.798077 waagent[2551]: 2026-04-14T23:48:00.797858Z INFO Daemon Daemon Successfully mounted dvd Apr 14 23:48:00.813169 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Apr 14 23:48:00.814353 waagent[2551]: 2026-04-14T23:48:00.813618Z INFO Daemon Daemon Detect protocol endpoint Apr 14 23:48:00.815157 waagent[2551]: 2026-04-14T23:48:00.815119Z INFO Daemon Daemon Clean protocol and wireserver endpoint Apr 14 23:48:00.816518 waagent[2551]: 2026-04-14T23:48:00.816488Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Apr 14 23:48:00.818011 waagent[2551]: 2026-04-14T23:48:00.817982Z INFO Daemon Daemon Test for route to 168.63.129.16 Apr 14 23:48:00.819439 waagent[2551]: 2026-04-14T23:48:00.819388Z INFO Daemon Daemon Route to 168.63.129.16 exists Apr 14 23:48:00.820509 waagent[2551]: 2026-04-14T23:48:00.819639Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Apr 14 23:48:00.831225 waagent[2551]: 2026-04-14T23:48:00.831192Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Apr 14 23:48:00.836214 waagent[2551]: 2026-04-14T23:48:00.831505Z INFO Daemon Daemon Wire protocol version:2012-11-30 Apr 14 23:48:00.836214 waagent[2551]: 2026-04-14T23:48:00.831632Z INFO Daemon Daemon Server preferred version:2015-04-05 Apr 14 23:48:00.896898 waagent[2551]: 2026-04-14T23:48:00.896852Z INFO Daemon Daemon Initializing goal state during protocol detection Apr 14 23:48:00.897128 waagent[2551]: 2026-04-14T23:48:00.897099Z INFO Daemon Daemon Forcing an update of the goal state. Apr 14 23:48:00.900691 waagent[2551]: 2026-04-14T23:48:00.900657Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Apr 14 23:48:00.911167 waagent[2551]: 2026-04-14T23:48:00.911134Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.179 Apr 14 23:48:00.911623 waagent[2551]: 2026-04-14T23:48:00.911591Z INFO Daemon Apr 14 23:48:00.914777 waagent[2551]: 2026-04-14T23:48:00.911680Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: abb0c9f0-16ba-43d2-94bc-1e222621893f eTag: 17803629307501593025 source: Fabric] Apr 14 23:48:00.914777 waagent[2551]: 2026-04-14T23:48:00.911926Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Apr 14 23:48:00.914777 waagent[2551]: 2026-04-14T23:48:00.912200Z INFO Daemon Apr 14 23:48:00.914777 waagent[2551]: 2026-04-14T23:48:00.912362Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Apr 14 23:48:00.927476 waagent[2551]: 2026-04-14T23:48:00.927450Z INFO Daemon Daemon Downloading artifacts profile blob Apr 14 23:48:01.005435 waagent[2551]: 2026-04-14T23:48:01.005349Z INFO Daemon Downloaded certificate {'thumbprint': '6324C7883F591FCECD86936ED3841CAC5E139BA3', 'hasPrivateKey': True} Apr 14 23:48:01.007277 waagent[2551]: 2026-04-14T23:48:01.005766Z INFO Daemon Fetch goal state completed Apr 14 23:48:01.012314 waagent[2551]: 2026-04-14T23:48:01.012262Z INFO Daemon Daemon Starting provisioning Apr 14 23:48:01.013199 waagent[2551]: 2026-04-14T23:48:01.012471Z INFO Daemon Daemon Handle ovf-env.xml. Apr 14 23:48:01.013199 waagent[2551]: 2026-04-14T23:48:01.012649Z INFO Daemon Daemon Set hostname [ci-4628.0.0-n-4166ffaadb] Apr 14 23:48:01.020485 waagent[2551]: 2026-04-14T23:48:01.015067Z INFO Daemon Daemon Publish hostname [ci-4628.0.0-n-4166ffaadb] Apr 14 23:48:01.020485 waagent[2551]: 2026-04-14T23:48:01.015471Z INFO Daemon Daemon Examine /proc/net/route for primary interface Apr 14 23:48:01.020485 waagent[2551]: 2026-04-14T23:48:01.015763Z INFO Daemon Daemon Primary interface is [eth0] Apr 14 23:48:01.023027 systemd-networkd[2246]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Apr 14 23:48:01.023035 systemd-networkd[2246]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Apr 14 23:48:01.023085 systemd-networkd[2246]: eth0: DHCP lease lost Apr 14 23:48:01.035529 waagent[2551]: 2026-04-14T23:48:01.035488Z INFO Daemon Daemon Create user account if not exists Apr 14 23:48:01.036695 waagent[2551]: 2026-04-14T23:48:01.036662Z INFO Daemon Daemon User core already exists, skip useradd Apr 14 23:48:01.038204 waagent[2551]: 2026-04-14T23:48:01.038138Z INFO Daemon Daemon Configure sudoer Apr 14 23:48:01.039379 waagent[2551]: 2026-04-14T23:48:01.039342Z INFO Daemon Daemon Configure sshd Apr 14 23:48:01.042985 waagent[2551]: 2026-04-14T23:48:01.039664Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Apr 14 23:48:01.042985 waagent[2551]: 2026-04-14T23:48:01.039835Z INFO Daemon Daemon Deploy ssh public key. Apr 14 23:48:01.043550 systemd-networkd[2246]: eth0: DHCPv4 address 10.0.0.11/24, gateway 10.0.0.1 acquired from 168.63.129.16 Apr 14 23:48:02.096394 waagent[2551]: 2026-04-14T23:48:02.096353Z INFO Daemon Daemon Provisioning complete Apr 14 23:48:02.106183 waagent[2551]: 2026-04-14T23:48:02.106153Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Apr 14 23:48:02.111625 waagent[2551]: 2026-04-14T23:48:02.106366Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Apr 14 23:48:02.111625 waagent[2551]: 2026-04-14T23:48:02.106651Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Apr 14 23:48:02.208530 waagent[2630]: 2026-04-14T23:48:02.208470Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Apr 14 23:48:02.208800 waagent[2630]: 2026-04-14T23:48:02.208562Z INFO ExtHandler ExtHandler OS: flatcar 4628.0.0 Apr 14 23:48:02.208800 waagent[2630]: 2026-04-14T23:48:02.208610Z INFO ExtHandler ExtHandler Python: 3.12.12 Apr 14 23:48:02.208800 waagent[2630]: 2026-04-14T23:48:02.208648Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Apr 14 23:48:02.222363 waagent[2630]: 2026-04-14T23:48:02.222320Z INFO ExtHandler ExtHandler Distro: flatcar-4628.0.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.12; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Apr 14 23:48:02.222506 waagent[2630]: 2026-04-14T23:48:02.222483Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Apr 14 23:48:02.222559 waagent[2630]: 2026-04-14T23:48:02.222543Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Apr 14 23:48:02.228945 waagent[2630]: 2026-04-14T23:48:02.228887Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Apr 14 23:48:02.235728 waagent[2630]: 2026-04-14T23:48:02.235702Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.179 Apr 14 23:48:02.236028 waagent[2630]: 2026-04-14T23:48:02.236003Z INFO ExtHandler Apr 14 23:48:02.236076 waagent[2630]: 2026-04-14T23:48:02.236057Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 34c0d7c9-cb70-4fef-8470-c08d5f8279b8 eTag: 17803629307501593025 source: Fabric] Apr 14 23:48:02.236253 waagent[2630]: 2026-04-14T23:48:02.236235Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Apr 14 23:48:02.236596 waagent[2630]: 2026-04-14T23:48:02.236574Z INFO ExtHandler Apr 14 23:48:02.236635 waagent[2630]: 2026-04-14T23:48:02.236619Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Apr 14 23:48:02.247748 waagent[2630]: 2026-04-14T23:48:02.247727Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Apr 14 23:48:02.324468 waagent[2630]: 2026-04-14T23:48:02.324392Z INFO ExtHandler Downloaded certificate {'thumbprint': '6324C7883F591FCECD86936ED3841CAC5E139BA3', 'hasPrivateKey': True} Apr 14 23:48:02.324766 waagent[2630]: 2026-04-14T23:48:02.324740Z INFO ExtHandler Fetch goal state completed Apr 14 23:48:02.333060 waagent[2630]: 2026-04-14T23:48:02.333018Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.5 27 Jan 2026 (Library: OpenSSL 3.5.5 27 Jan 2026) Apr 14 23:48:02.335827 waagent[2630]: 2026-04-14T23:48:02.335783Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2630 Apr 14 23:48:02.335935 waagent[2630]: 2026-04-14T23:48:02.335912Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Apr 14 23:48:02.336157 waagent[2630]: 2026-04-14T23:48:02.336137Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Apr 14 23:48:02.337073 waagent[2630]: 2026-04-14T23:48:02.337039Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4628.0.0', '', 'Flatcar Container Linux by Kinvolk'] Apr 14 23:48:02.337325 waagent[2630]: 2026-04-14T23:48:02.337300Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4628.0.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Apr 14 23:48:02.337436 waagent[2630]: 2026-04-14T23:48:02.337391Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Apr 14 23:48:02.337799 waagent[2630]: 2026-04-14T23:48:02.337773Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Apr 14 23:48:02.348342 waagent[2630]: 2026-04-14T23:48:02.348281Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Apr 14 23:48:02.348583 waagent[2630]: 2026-04-14T23:48:02.348443Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Apr 14 23:48:02.353428 waagent[2630]: 2026-04-14T23:48:02.353242Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Apr 14 23:48:02.358205 systemd[1]: Reload requested from client PID 2645 ('systemctl') (unit waagent.service)... Apr 14 23:48:02.358218 systemd[1]: Reloading... Apr 14 23:48:02.423425 zram_generator::config[2693]: No configuration found. Apr 14 23:48:02.572366 systemd[1]: /usr/lib/systemd/system/update-engine.service:10: Support for option BlockIOWeight= has been removed and it is ignored Apr 14 23:48:02.624778 systemd[1]: Reloading finished in 266 ms. Apr 14 23:48:02.648095 waagent[2630]: 2026-04-14T23:48:02.646718Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Apr 14 23:48:02.648095 waagent[2630]: 2026-04-14T23:48:02.646813Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Apr 14 23:48:02.843965 waagent[2630]: 2026-04-14T23:48:02.843918Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Apr 14 23:48:02.844172 waagent[2630]: 2026-04-14T23:48:02.844150Z 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] Apr 14 23:48:02.844756 waagent[2630]: 2026-04-14T23:48:02.844685Z INFO ExtHandler ExtHandler Starting env monitor service. Apr 14 23:48:02.844801 waagent[2630]: 2026-04-14T23:48:02.844783Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Apr 14 23:48:02.844920 waagent[2630]: 2026-04-14T23:48:02.844902Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Apr 14 23:48:02.845085 waagent[2630]: 2026-04-14T23:48:02.845066Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Apr 14 23:48:02.845367 waagent[2630]: 2026-04-14T23:48:02.845338Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Apr 14 23:48:02.845768 waagent[2630]: 2026-04-14T23:48:02.845734Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Apr 14 23:48:02.845870 waagent[2630]: 2026-04-14T23:48:02.845837Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Apr 14 23:48:02.845928 waagent[2630]: 2026-04-14T23:48:02.845905Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Apr 14 23:48:02.845928 waagent[2630]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Apr 14 23:48:02.845928 waagent[2630]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Apr 14 23:48:02.845928 waagent[2630]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Apr 14 23:48:02.845928 waagent[2630]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Apr 14 23:48:02.845928 waagent[2630]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Apr 14 23:48:02.845928 waagent[2630]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Apr 14 23:48:02.846322 waagent[2630]: 2026-04-14T23:48:02.846280Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Apr 14 23:48:02.846484 waagent[2630]: 2026-04-14T23:48:02.846458Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Apr 14 23:48:02.846628 waagent[2630]: 2026-04-14T23:48:02.846531Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Apr 14 23:48:02.846710 waagent[2630]: 2026-04-14T23:48:02.846692Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Apr 14 23:48:02.847391 waagent[2630]: 2026-04-14T23:48:02.847369Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Apr 14 23:48:02.847610 waagent[2630]: 2026-04-14T23:48:02.847586Z INFO EnvHandler ExtHandler Configure routes Apr 14 23:48:02.847679 waagent[2630]: 2026-04-14T23:48:02.847648Z INFO EnvHandler ExtHandler Gateway:None Apr 14 23:48:02.847733 waagent[2630]: 2026-04-14T23:48:02.847706Z INFO EnvHandler ExtHandler Routes:None Apr 14 23:48:02.853306 waagent[2630]: 2026-04-14T23:48:02.853276Z INFO ExtHandler ExtHandler Apr 14 23:48:02.854434 waagent[2630]: 2026-04-14T23:48:02.853745Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 567002f0-5d22-4d5c-ad0e-f16fd7768d47 correlation f027ef64-6d66-4558-910f-39a678090298 created: 2026-04-14T23:47:25.835175Z] Apr 14 23:48:02.854434 waagent[2630]: 2026-04-14T23:48:02.854051Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Apr 14 23:48:02.854696 waagent[2630]: 2026-04-14T23:48:02.854664Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 1 ms] Apr 14 23:48:02.869496 waagent[2630]: 2026-04-14T23:48:02.869453Z INFO MonitorHandler ExtHandler Network interfaces: Apr 14 23:48:02.869496 waagent[2630]: Executing ['ip', '-a', '-o', 'link']: Apr 14 23:48:02.869496 waagent[2630]: 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 Apr 14 23:48:02.869496 waagent[2630]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:9a:4a:66 brd ff:ff:ff:ff:ff:ff\ alias Network Device\ altname enx0022489a4a66 Apr 14 23:48:02.869496 waagent[2630]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:9a:4a:66 brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0\ altname enp0s0\ altname ens1 Apr 14 23:48:02.869496 waagent[2630]: Executing ['ip', '-4', '-a', '-o', 'address']: Apr 14 23:48:02.869496 waagent[2630]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Apr 14 23:48:02.869496 waagent[2630]: 2: eth0 inet 10.0.0.11/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Apr 14 23:48:02.869496 waagent[2630]: Executing ['ip', '-6', '-a', '-o', 'address']: Apr 14 23:48:02.869496 waagent[2630]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Apr 14 23:48:02.869496 waagent[2630]: 2: eth0 inet6 fe80::222:48ff:fe9a:4a66/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Apr 14 23:48:02.899665 waagent[2630]: 2026-04-14T23:48:02.899600Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Apr 14 23:48:02.899665 waagent[2630]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Apr 14 23:48:02.899665 waagent[2630]: pkts bytes target prot opt in out source destination Apr 14 23:48:02.899665 waagent[2630]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Apr 14 23:48:02.899665 waagent[2630]: pkts bytes target prot opt in out source destination Apr 14 23:48:02.899665 waagent[2630]: Chain OUTPUT (policy ACCEPT 6 packets, 884 bytes) Apr 14 23:48:02.899665 waagent[2630]: pkts bytes target prot opt in out source destination Apr 14 23:48:02.899665 waagent[2630]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Apr 14 23:48:02.899665 waagent[2630]: 3 156 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Apr 14 23:48:02.899665 waagent[2630]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Apr 14 23:48:02.900904 waagent[2630]: 2026-04-14T23:48:02.900866Z WARNING ExtHandler ExtHandler Failed to get firewall packets: 'iptables -w -t security -L OUTPUT --zero OUTPUT -nxv' failed: 2 (iptables v1.8.11 (nf_tables): Illegal option `--numeric' with this command Apr 14 23:48:02.900904 waagent[2630]: Try `iptables -h' or 'iptables --help' for more information.) Apr 14 23:48:02.901230 waagent[2630]: 2026-04-14T23:48:02.901200Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 8CEEDA63-B106-43FC-B965-92799981E07B;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Apr 14 23:48:02.902744 waagent[2630]: 2026-04-14T23:48:02.902700Z INFO EnvHandler ExtHandler Current Firewall rules: Apr 14 23:48:02.902744 waagent[2630]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Apr 14 23:48:02.902744 waagent[2630]: pkts bytes target prot opt in out source destination Apr 14 23:48:02.902744 waagent[2630]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Apr 14 23:48:02.902744 waagent[2630]: pkts bytes target prot opt in out source destination Apr 14 23:48:02.902744 waagent[2630]: Chain OUTPUT (policy ACCEPT 6 packets, 884 bytes) Apr 14 23:48:02.902744 waagent[2630]: pkts bytes target prot opt in out source destination Apr 14 23:48:02.902744 waagent[2630]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Apr 14 23:48:02.902744 waagent[2630]: 3 156 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Apr 14 23:48:02.902744 waagent[2630]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Apr 14 23:48:11.892510 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 14 23:48:11.893737 systemd[1]: Started sshd@0-1-10.0.0.11:22-4.175.71.9:44676.service - OpenSSH per-connection server daemon (4.175.71.9:44676). Apr 14 23:48:12.044687 sshd[2784]: Accepted publickey for core from 4.175.71.9 port 44676 ssh2: RSA SHA256:jU0Ghxf3Rz+/3U8fLoBeQXL6kRLDhg+OjSDIl2N28Aw Apr 14 23:48:12.045585 sshd-session[2784]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 14 23:48:12.055266 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 14 23:48:12.057642 systemd-logind[2437]: New session '3' of user 'core' with class 'user' and type 'tty'. Apr 14 23:48:12.063210 (systemd)[2788]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Apr 14 23:48:12.064867 systemd-logind[2437]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Apr 14 23:48:12.203712 systemd[2788]: Queued start job for default target default.target. Apr 14 23:48:12.210023 systemd[2788]: Created slice app.slice - User Application Slice. Apr 14 23:48:12.210054 systemd[2788]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Apr 14 23:48:12.210066 systemd[2788]: Reached target machines.target - Virtual Machines and Containers. Apr 14 23:48:12.210098 systemd[2788]: Reached target paths.target - Paths. Apr 14 23:48:12.210116 systemd[2788]: Reached target timers.target - Timers. Apr 14 23:48:12.210921 systemd[2788]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 14 23:48:12.212110 systemd[2788]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Apr 14 23:48:12.212761 systemd[2788]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Apr 14 23:48:12.220956 systemd[2788]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 14 23:48:12.221724 systemd[2788]: Reached target sockets.target - Sockets. Apr 14 23:48:12.222455 systemd[2788]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Apr 14 23:48:12.222551 systemd[2788]: Reached target basic.target - Basic System. Apr 14 23:48:12.222583 systemd[2788]: Reached target default.target - Main User Target. Apr 14 23:48:12.222603 systemd[2788]: Startup finished in 154ms. Apr 14 23:48:12.222946 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 14 23:48:12.226604 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 14 23:48:12.288692 systemd[1]: Started sshd@1-2-10.0.0.11:22-4.175.71.9:44678.service - OpenSSH per-connection server daemon (4.175.71.9:44678). Apr 14 23:48:12.395364 sshd[2802]: Accepted publickey for core from 4.175.71.9 port 44678 ssh2: RSA SHA256:jU0Ghxf3Rz+/3U8fLoBeQXL6kRLDhg+OjSDIl2N28Aw Apr 14 23:48:12.396220 sshd-session[2802]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 14 23:48:12.398972 systemd-logind[2437]: New session '5' of user 'core' with class 'user' and type 'tty'. Apr 14 23:48:12.405530 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 14 23:48:12.441571 sshd[2806]: Connection closed by 4.175.71.9 port 44678 Apr 14 23:48:12.442521 sshd-session[2802]: pam_unix(sshd:session): session closed for user core Apr 14 23:48:12.444444 systemd[1]: sshd@1-2-10.0.0.11:22-4.175.71.9:44678.service: Deactivated successfully. Apr 14 23:48:12.445594 systemd[1]: session-5.scope: Deactivated successfully. Apr 14 23:48:12.446659 systemd-logind[2437]: Session 5 logged out. Waiting for processes to exit. Apr 14 23:48:12.447221 systemd-logind[2437]: Removed session 5. Apr 14 23:48:12.465358 systemd[1]: Started sshd@2-4097-10.0.0.11:22-4.175.71.9:44692.service - OpenSSH per-connection server daemon (4.175.71.9:44692). Apr 14 23:48:12.574771 sshd[2812]: Accepted publickey for core from 4.175.71.9 port 44692 ssh2: RSA SHA256:jU0Ghxf3Rz+/3U8fLoBeQXL6kRLDhg+OjSDIl2N28Aw Apr 14 23:48:12.575534 sshd-session[2812]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 14 23:48:12.578443 systemd-logind[2437]: New session '6' of user 'core' with class 'user' and type 'tty'. Apr 14 23:48:12.581544 systemd[1]: Started session-6.scope - Session 6 of User core. Apr 14 23:48:12.618445 sshd[2816]: Connection closed by 4.175.71.9 port 44692 Apr 14 23:48:12.619528 sshd-session[2812]: pam_unix(sshd:session): session closed for user core Apr 14 23:48:12.621428 systemd[1]: sshd@2-4097-10.0.0.11:22-4.175.71.9:44692.service: Deactivated successfully. Apr 14 23:48:12.622467 systemd[1]: session-6.scope: Deactivated successfully. Apr 14 23:48:12.623027 systemd-logind[2437]: Session 6 logged out. Waiting for processes to exit. Apr 14 23:48:12.623943 systemd-logind[2437]: Removed session 6. Apr 14 23:48:12.642362 systemd[1]: Started sshd@3-3-10.0.0.11:22-4.175.71.9:44704.service - OpenSSH per-connection server daemon (4.175.71.9:44704). Apr 14 23:48:12.743786 sshd[2823]: Accepted publickey for core from 4.175.71.9 port 44704 ssh2: RSA SHA256:jU0Ghxf3Rz+/3U8fLoBeQXL6kRLDhg+OjSDIl2N28Aw Apr 14 23:48:12.744569 sshd-session[2823]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 14 23:48:12.747472 systemd-logind[2437]: New session '7' of user 'core' with class 'user' and type 'tty'. Apr 14 23:48:12.753549 systemd[1]: Started session-7.scope - Session 7 of User core. Apr 14 23:48:12.790589 sshd[2827]: Connection closed by 4.175.71.9 port 44704 Apr 14 23:48:12.791768 sshd-session[2823]: pam_unix(sshd:session): session closed for user core Apr 14 23:48:12.793491 systemd[1]: sshd@3-3-10.0.0.11:22-4.175.71.9:44704.service: Deactivated successfully. Apr 14 23:48:12.794610 systemd[1]: session-7.scope: Deactivated successfully. Apr 14 23:48:12.795174 systemd-logind[2437]: Session 7 logged out. Waiting for processes to exit. Apr 14 23:48:12.796156 systemd-logind[2437]: Removed session 7. Apr 14 23:48:12.815335 systemd[1]: Started sshd@4-4098-10.0.0.11:22-4.175.71.9:44720.service - OpenSSH per-connection server daemon (4.175.71.9:44720). Apr 14 23:48:12.924439 sshd[2833]: Accepted publickey for core from 4.175.71.9 port 44720 ssh2: RSA SHA256:jU0Ghxf3Rz+/3U8fLoBeQXL6kRLDhg+OjSDIl2N28Aw Apr 14 23:48:12.925025 sshd-session[2833]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 14 23:48:12.928187 systemd-logind[2437]: New session '8' of user 'core' with class 'user' and type 'tty'. Apr 14 23:48:12.934524 systemd[1]: Started session-8.scope - Session 8 of User core. Apr 14 23:48:12.992578 sudo[2838]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Apr 14 23:48:12.992771 sudo[2838]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 14 23:48:13.007003 sudo[2838]: pam_unix(sudo:session): session closed for user root Apr 14 23:48:13.021567 sshd[2837]: Connection closed by 4.175.71.9 port 44720 Apr 14 23:48:13.022574 sshd-session[2833]: pam_unix(sshd:session): session closed for user core Apr 14 23:48:13.024129 systemd[1]: sshd@4-4098-10.0.0.11:22-4.175.71.9:44720.service: Deactivated successfully. Apr 14 23:48:13.025442 systemd[1]: session-8.scope: Deactivated successfully. Apr 14 23:48:13.026751 systemd-logind[2437]: Session 8 logged out. Waiting for processes to exit. Apr 14 23:48:13.027369 systemd-logind[2437]: Removed session 8. Apr 14 23:48:13.046339 systemd[1]: Started sshd@5-4099-10.0.0.11:22-4.175.71.9:44736.service - OpenSSH per-connection server daemon (4.175.71.9:44736). Apr 14 23:48:13.159107 sshd[2845]: Accepted publickey for core from 4.175.71.9 port 44736 ssh2: RSA SHA256:jU0Ghxf3Rz+/3U8fLoBeQXL6kRLDhg+OjSDIl2N28Aw Apr 14 23:48:13.159902 sshd-session[2845]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 14 23:48:13.163186 systemd-logind[2437]: New session '9' of user 'core' with class 'user' and type 'tty'. Apr 14 23:48:13.166543 systemd[1]: Started session-9.scope - Session 9 of User core. Apr 14 23:48:13.192890 sudo[2851]: 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 Apr 14 23:48:13.193075 sudo[2851]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 14 23:48:13.194180 sudo[2851]: pam_unix(sudo:session): session closed for user root Apr 14 23:48:13.199149 sudo[2850]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Apr 14 23:48:13.199336 sudo[2850]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 14 23:48:13.204497 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 14 23:48:13.233000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Apr 14 23:48:13.235137 augenrules[2875]: No rules Apr 14 23:48:13.235745 kernel: kauditd_printk_skb: 55 callbacks suppressed Apr 14 23:48:13.235771 kernel: audit: type=1305 audit(1776210493.233:179): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Apr 14 23:48:13.236842 systemd[1]: audit-rules.service: Deactivated successfully. Apr 14 23:48:13.237021 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 14 23:48:13.237976 sudo[2850]: pam_unix(sudo:session): session closed for user root Apr 14 23:48:13.233000 audit[2875]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff21883f50 a2=420 a3=0 items=0 ppid=2856 pid=2875 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) Apr 14 23:48:13.242901 kernel: audit: type=1300 audit(1776210493.233:179): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff21883f50 a2=420 a3=0 items=0 ppid=2856 pid=2875 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) Apr 14 23:48:13.233000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Apr 14 23:48:13.244703 kernel: audit: type=1327 audit(1776210493.233:179): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Apr 14 23:48:13.235000 audit[2850]: AUDIT1106 pid=2850 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' Apr 14 23:48:13.247584 kernel: audit: type=1106 audit(1776210493.235:180): pid=2850 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' Apr 14 23:48:13.235000 audit[2850]: AUDIT1104 pid=2850 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' Apr 14 23:48:13.250320 kernel: audit: type=1104 audit(1776210493.235:181): pid=2850 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' Apr 14 23:48:13.237000 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' Apr 14 23:48:13.253019 kernel: audit: type=1130 audit(1776210493.237:182): 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' Apr 14 23:48:13.237000 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' Apr 14 23:48:13.255806 sshd[2849]: Connection closed by 4.175.71.9 port 44736 Apr 14 23:48:13.256098 sshd-session[2845]: pam_unix(sshd:session): session closed for user core Apr 14 23:48:13.256654 kernel: audit: type=1131 audit(1776210493.237:183): 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' Apr 14 23:48:13.252000 audit[2845]: AUDIT1106 pid=2845 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' Apr 14 23:48:13.263548 kernel: audit: type=1106 audit(1776210493.252:184): pid=2845 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' Apr 14 23:48:13.257983 systemd[1]: sshd@5-4099-10.0.0.11:22-4.175.71.9:44736.service: Deactivated successfully. Apr 14 23:48:13.259845 systemd-logind[2437]: Session 9 logged out. Waiting for processes to exit. Apr 14 23:48:13.260351 systemd[1]: session-9.scope: Deactivated successfully. Apr 14 23:48:13.262499 systemd-logind[2437]: Removed session 9. Apr 14 23:48:13.252000 audit[2845]: AUDIT1104 pid=2845 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' Apr 14 23:48:13.256000 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.11:22-4.175.71.9:44736 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:48:13.271646 kernel: audit: type=1104 audit(1776210493.252:185): pid=2845 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' Apr 14 23:48:13.271680 kernel: audit: type=1131 audit(1776210493.256:186): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4099-10.0.0.11:22-4.175.71.9:44736 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:48:13.280000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4100-10.0.0.11:22-4.175.71.9:44742 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:48:13.281316 systemd[1]: Started sshd@6-4100-10.0.0.11:22-4.175.71.9:44742.service - OpenSSH per-connection server daemon (4.175.71.9:44742). Apr 14 23:48:13.386000 audit[2884]: AUDIT1101 pid=2884 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_time,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' Apr 14 23:48:13.388485 sshd[2884]: Accepted publickey for core from 4.175.71.9 port 44742 ssh2: RSA SHA256:jU0Ghxf3Rz+/3U8fLoBeQXL6kRLDhg+OjSDIl2N28Aw Apr 14 23:48:13.387000 audit[2884]: AUDIT1103 pid=2884 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' Apr 14 23:48:13.387000 audit[2884]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7ffee5212870 a2=3 a3=0 items=0 ppid=1 pid=2884 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) Apr 14 23:48:13.387000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Apr 14 23:48:13.389320 sshd-session[2884]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 14 23:48:13.392563 systemd-logind[2437]: New session '10' of user 'core' with class 'user' and type 'tty'. Apr 14 23:48:13.401561 systemd[1]: Started session-10.scope - Session 10 of User core. Apr 14 23:48:13.401000 audit[2884]: AUDIT1105 pid=2884 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' Apr 14 23:48:13.403000 audit[2888]: AUDIT1103 pid=2888 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' Apr 14 23:48:13.434394 sshd[2888]: Connection closed by 4.175.71.9 port 44742 Apr 14 23:48:13.435530 sshd-session[2884]: pam_unix(sshd:session): session closed for user core Apr 14 23:48:13.434000 audit[2884]: AUDIT1106 pid=2884 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' Apr 14 23:48:13.434000 audit[2884]: AUDIT1104 pid=2884 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=4.175.71.9 addr=4.175.71.9 terminal=ssh res=success' Apr 14 23:48:13.437322 systemd[1]: sshd@6-4100-10.0.0.11:22-4.175.71.9:44742.service: Deactivated successfully. Apr 14 23:48:13.436000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4100-10.0.0.11:22-4.175.71.9:44742 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Apr 14 23:48:13.438507 systemd[1]: session-10.scope: Deactivated successfully. Apr 14 23:48:13.439075 systemd-logind[2437]: Session 10 logged out. Waiting for processes to exit. Apr 14 23:48:13.440012 systemd-logind[2437]: Removed session 10.