Sep 9 01:35:50.538071 kernel: Linux version 6.12.109-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 15.3.0 p8) 15.3.0, GNU ld (Gentoo 2.46.0 p1) 2.46.0) #1 SMP PREEMPT_DYNAMIC Tue Sep 8 22:30:55 -00 2026 Sep 9 01:35:50.538102 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=8b01db594d78ebb1caee7895d3f2ad3faf1dafe1120cbd21e7a5a04ef4e9e018 Sep 9 01:35:50.538113 kernel: BIOS-provided physical RAM map: Sep 9 01:35:50.538121 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Sep 9 01:35:50.538129 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Sep 9 01:35:50.538137 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000044fdfff] usable Sep 9 01:35:50.538145 kernel: BIOS-e820: [mem 0x00000000044fe000-0x00000000048fdfff] reserved Sep 9 01:35:50.538153 kernel: BIOS-e820: [mem 0x00000000048fe000-0x000000003ff1efff] usable Sep 9 01:35:50.538161 kernel: BIOS-e820: [mem 0x000000003ff1f000-0x000000003ffc8fff] reserved Sep 9 01:35:50.538168 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Sep 9 01:35:50.538176 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Sep 9 01:35:50.538183 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Sep 9 01:35:50.538191 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable Sep 9 01:35:50.538200 kernel: printk: legacy bootconsole [earlyser0] enabled Sep 9 01:35:50.538209 kernel: NX (Execute Disable) protection: active Sep 9 01:35:50.538217 kernel: APIC: Static calls initialized Sep 9 01:35:50.538225 kernel: efi: EFI v2.7 by Microsoft Sep 9 01:35:50.538235 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff88000 SMBIOS 3.0=0x3ff86000 MEMATTR=0x3ea69018 RNG=0x3ffd2018 Sep 9 01:35:50.538243 kernel: random: crng init done Sep 9 01:35:50.538251 kernel: secureboot: Secure boot disabled Sep 9 01:35:50.538259 kernel: SMBIOS 3.1.0 present. Sep 9 01:35:50.538267 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Sep 9 01:35:50.538275 kernel: DMI: Memory slots populated: 2/2 Sep 9 01:35:50.538282 kernel: Hypervisor detected: Microsoft Hyper-V Sep 9 01:35:50.538290 kernel: Hyper-V: privilege flags low 0xae7f, high 0x3b8030, hints 0x9e4e24, misc 0xe0bed7b2 Sep 9 01:35:50.538298 kernel: Hyper-V: Nested features: 0x3e0101 Sep 9 01:35:50.538306 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Sep 9 01:35:50.538314 kernel: Hyper-V: Using hypercall for remote TLB flush Sep 9 01:35:50.538324 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Sep 9 01:35:50.538332 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Sep 9 01:35:50.538340 kernel: tsc: Detected 2300.000 MHz processor Sep 9 01:35:50.538348 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 9 01:35:50.538358 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 9 01:35:50.538366 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x10000000000 Sep 9 01:35:50.538375 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Sep 9 01:35:50.538384 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 9 01:35:50.538394 kernel: e820: update [mem 0x48000000-0xffffffff] usable ==> reserved Sep 9 01:35:50.538402 kernel: last_pfn = 0x40000 max_arch_pfn = 0x10000000000 Sep 9 01:35:50.538410 kernel: Using GB pages for direct mapping Sep 9 01:35:50.538419 kernel: ACPI: Early table checksum verification disabled Sep 9 01:35:50.538430 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Sep 9 01:35:50.538440 kernel: ACPI: XSDT 0x000000003FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 9 01:35:50.538449 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 9 01:35:50.538458 kernel: ACPI: DSDT 0x000000003FFD6000 01E22B (v02 MSFTVM DSDT01 00000001 INTL 20230628) Sep 9 01:35:50.538466 kernel: ACPI: FACS 0x000000003FFFE000 000040 Sep 9 01:35:50.538475 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 9 01:35:50.538484 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 9 01:35:50.538494 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 9 01:35:50.538503 kernel: ACPI: APIC 0x000000003FFD5000 000058 (v05 HVLITE HVLITETB 00000000 MSHV 00000000) Sep 9 01:35:50.538511 kernel: ACPI: SRAT 0x000000003FFD4000 0000A0 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) Sep 9 01:35:50.538520 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 9 01:35:50.538529 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Sep 9 01:35:50.538537 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff422a] Sep 9 01:35:50.538546 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Sep 9 01:35:50.538556 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Sep 9 01:35:50.538565 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Sep 9 01:35:50.538573 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Sep 9 01:35:50.538582 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5057] Sep 9 01:35:50.538591 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd409f] Sep 9 01:35:50.538600 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Sep 9 01:35:50.538608 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Sep 9 01:35:50.538619 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] Sep 9 01:35:50.538628 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00001000-0x2bfffffff] Sep 9 01:35:50.538636 kernel: NODE_DATA(0) allocated [mem 0x2bfff6dc0-0x2bfffdfff] Sep 9 01:35:50.538645 kernel: Zone ranges: Sep 9 01:35:50.538654 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 9 01:35:50.538662 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Sep 9 01:35:50.538671 kernel: Normal [mem 0x0000000100000000-0x00000002bfffffff] Sep 9 01:35:50.538681 kernel: Device empty Sep 9 01:35:50.538690 kernel: Movable zone start for each node Sep 9 01:35:50.538699 kernel: Early memory node ranges Sep 9 01:35:50.538707 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Sep 9 01:35:50.538716 kernel: node 0: [mem 0x0000000000100000-0x00000000044fdfff] Sep 9 01:35:50.538725 kernel: node 0: [mem 0x00000000048fe000-0x000000003ff1efff] Sep 9 01:35:50.538733 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Sep 9 01:35:50.538757 kernel: node 0: [mem 0x0000000100000000-0x00000002bfffffff] Sep 9 01:35:50.538768 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff] Sep 9 01:35:50.538777 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 9 01:35:50.538786 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Sep 9 01:35:50.538795 kernel: On node 0, zone DMA32: 1024 pages in unavailable ranges Sep 9 01:35:50.538803 kernel: On node 0, zone DMA32: 224 pages in unavailable ranges Sep 9 01:35:50.538812 kernel: ACPI: PM-Timer IO Port: 0x408 Sep 9 01:35:50.538821 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Sep 9 01:35:50.538831 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Sep 9 01:35:50.538840 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 9 01:35:50.538849 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Sep 9 01:35:50.538857 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Sep 9 01:35:50.538866 kernel: TSC deadline timer available Sep 9 01:35:50.538874 kernel: CPU topo: Max. logical packages: 1 Sep 9 01:35:50.538883 kernel: CPU topo: Max. logical dies: 1 Sep 9 01:35:50.538892 kernel: CPU topo: Max. dies per package: 1 Sep 9 01:35:50.538902 kernel: CPU topo: Max. threads per core: 2 Sep 9 01:35:50.538912 kernel: CPU topo: Num. cores per package: 1 Sep 9 01:35:50.538921 kernel: CPU topo: Num. threads per package: 2 Sep 9 01:35:50.538930 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs Sep 9 01:35:50.538940 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Sep 9 01:35:50.538950 kernel: Booting paravirtualized kernel on Hyper-V Sep 9 01:35:50.538961 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Sep 9 01:35:50.538971 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Sep 9 01:35:50.538981 kernel: percpu: Embedded 60 pages/cpu s208472 r8192 d29096 u1048576 Sep 9 01:35:50.538990 kernel: pcpu-alloc: s208472 r8192 d29096 u1048576 alloc=1*2097152 Sep 9 01:35:50.539000 kernel: pcpu-alloc: [0] 0 1 Sep 9 01:35:50.539009 kernel: Hyper-V: PV spinlocks enabled Sep 9 01:35:50.539019 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Sep 9 01:35:50.539032 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=8b01db594d78ebb1caee7895d3f2ad3faf1dafe1120cbd21e7a5a04ef4e9e018 Sep 9 01:35:50.539042 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Sep 9 01:35:50.539052 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 9 01:35:50.539062 kernel: Fallback order for Node 0: 0 Sep 9 01:35:50.539071 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2095807 Sep 9 01:35:50.539081 kernel: Policy zone: Normal Sep 9 01:35:50.539091 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 9 01:35:50.539102 kernel: software IO TLB: area num 2. Sep 9 01:35:50.539112 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 9 01:35:50.539121 kernel: ftrace: allocating 41466 entries in 164 pages Sep 9 01:35:50.539132 kernel: ftrace: allocated 164 pages with 3 groups Sep 9 01:35:50.539140 kernel: Dynamic Preempt: voluntary Sep 9 01:35:50.539148 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 9 01:35:50.539159 kernel: rcu: RCU event tracing is enabled. Sep 9 01:35:50.539177 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 9 01:35:50.539187 kernel: Trampoline variant of Tasks RCU enabled. Sep 9 01:35:50.539199 kernel: Rude variant of Tasks RCU enabled. Sep 9 01:35:50.539209 kernel: Tracing variant of Tasks RCU enabled. Sep 9 01:35:50.539219 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 9 01:35:50.539229 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 9 01:35:50.539239 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 9 01:35:50.539250 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 9 01:35:50.539260 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 9 01:35:50.539272 kernel: Using NULL legacy PIC Sep 9 01:35:50.539282 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0 Sep 9 01:35:50.539292 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 9 01:35:50.539303 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 9 01:35:50.539314 kernel: Console: colour dummy device 80x25 Sep 9 01:35:50.539324 kernel: printk: legacy console [tty1] enabled Sep 9 01:35:50.539334 kernel: printk: legacy console [ttyS0] enabled Sep 9 01:35:50.539345 kernel: printk: legacy bootconsole [earlyser0] disabled Sep 9 01:35:50.539355 kernel: ACPI: Core revision 20240827 Sep 9 01:35:50.539365 kernel: Failed to register legacy timer interrupt Sep 9 01:35:50.539375 kernel: APIC: Switch to symmetric I/O mode setup Sep 9 01:35:50.539387 kernel: x2apic enabled Sep 9 01:35:50.539397 kernel: APIC: Switched APIC routing to: physical x2apic Sep 9 01:35:50.539407 kernel: Hyper-V: Host Build 10.0.26102.1437-1-0 Sep 9 01:35:50.539417 kernel: Hyper-V: enabling crash_kexec_post_notifiers Sep 9 01:35:50.539428 kernel: Hyper-V: Disabling IBT because of Hyper-V bug Sep 9 01:35:50.539438 kernel: Hyper-V: Using IPI hypercalls Sep 9 01:35:50.539448 kernel: APIC: send_IPI() replaced with hv_send_ipi() Sep 9 01:35:50.539460 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Sep 9 01:35:50.539471 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Sep 9 01:35:50.539481 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Sep 9 01:35:50.539491 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Sep 9 01:35:50.539501 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Sep 9 01:35:50.539512 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212735223b2, max_idle_ns: 440795277976 ns Sep 9 01:35:50.539522 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4600.00 BogoMIPS (lpj=2300000) Sep 9 01:35:50.539534 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Sep 9 01:35:50.539544 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Sep 9 01:35:50.539554 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Sep 9 01:35:50.539564 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 9 01:35:50.539574 kernel: Spectre V2 : Mitigation: Retpolines Sep 9 01:35:50.539583 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Sep 9 01:35:50.539594 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Sep 9 01:35:50.539603 kernel: RETBleed: Vulnerable Sep 9 01:35:50.539613 kernel: Speculative Store Bypass: Vulnerable Sep 9 01:35:50.539624 kernel: active return thunk: its_return_thunk Sep 9 01:35:50.539634 kernel: ITS: Mitigation: Aligned branch/return thunks Sep 9 01:35:50.539643 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Sep 9 01:35:50.539653 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Sep 9 01:35:50.539663 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Sep 9 01:35:50.539673 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Sep 9 01:35:50.539682 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Sep 9 01:35:50.539692 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Sep 9 01:35:50.539702 kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' Sep 9 01:35:50.539712 kernel: x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' Sep 9 01:35:50.539723 kernel: x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' Sep 9 01:35:50.539733 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Sep 9 01:35:50.539764 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Sep 9 01:35:50.539774 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Sep 9 01:35:50.539784 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Sep 9 01:35:50.539794 kernel: x86/fpu: xstate_offset[11]: 2432, xstate_sizes[11]: 16 Sep 9 01:35:50.539804 kernel: x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 Sep 9 01:35:50.539813 kernel: x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 Sep 9 01:35:50.539823 kernel: x86/fpu: Enabled xstate features 0x608e7, context size is 10752 bytes, using 'compacted' format. Sep 9 01:35:50.539833 kernel: Freeing SMP alternatives memory: 36K Sep 9 01:35:50.539843 kernel: pid_max: default: 32768 minimum: 301 Sep 9 01:35:50.539854 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 9 01:35:50.539864 kernel: landlock: Up and running. Sep 9 01:35:50.539873 kernel: SELinux: Initializing. Sep 9 01:35:50.539883 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Sep 9 01:35:50.539893 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Sep 9 01:35:50.539903 kernel: smpboot: CPU0: Intel INTEL(R) XEON(R) PLATINUM 8573C (family: 0x6, model: 0xcf, stepping: 0x2) Sep 9 01:35:50.539913 kernel: Performance Events: unsupported p6 CPU model 207 no PMU driver, software events only. Sep 9 01:35:50.539923 kernel: signal: max sigframe size: 11952 Sep 9 01:35:50.539934 kernel: rcu: Hierarchical SRCU implementation. Sep 9 01:35:50.539945 kernel: rcu: Max phase no-delay instances is 400. Sep 9 01:35:50.539956 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 9 01:35:50.539966 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Sep 9 01:35:50.539976 kernel: smp: Bringing up secondary CPUs ... Sep 9 01:35:50.539986 kernel: smpboot: x86: Booting SMP configuration: Sep 9 01:35:50.539996 kernel: .... node #0, CPUs: #1 Sep 9 01:35:50.540006 kernel: smp: Brought up 1 node, 2 CPUs Sep 9 01:35:50.540016 kernel: smpboot: Total of 2 processors activated (9200.00 BogoMIPS) Sep 9 01:35:50.540029 kernel: Memory: 8058676K/8383228K available (14336K kernel code, 2475K rwdata, 32660K rodata, 16148K init, 1892K bss, 318548K reserved, 0K cma-reserved) Sep 9 01:35:50.540038 kernel: devtmpfs: initialized Sep 9 01:35:50.540047 kernel: x86/mm: Memory block size: 128MB Sep 9 01:35:50.540057 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Sep 9 01:35:50.540066 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Sep 9 01:35:50.540075 kernel: pinctrl core: initialized pinctrl subsystem Sep 9 01:35:50.540084 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 9 01:35:50.540096 kernel: audit: initializing netlink subsys (disabled) Sep 9 01:35:50.540106 kernel: audit: type=2000 audit(1788917744.073:1): state=initialized audit_enabled=0 res=1 Sep 9 01:35:50.540115 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 9 01:35:50.540124 kernel: thermal_sys: Registered thermal governor 'user_space' Sep 9 01:35:50.540134 kernel: cpuidle: using governor menu Sep 9 01:35:50.540143 kernel: efi: Freeing EFI boot services memory: 34940K Sep 9 01:35:50.540152 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 9 01:35:50.540164 kernel: dca service started, version 1.12.1 Sep 9 01:35:50.540174 kernel: e820: reserve RAM buffer [mem 0x044fe000-0x07ffffff] Sep 9 01:35:50.540183 kernel: e820: reserve RAM buffer [mem 0x3ff1f000-0x3fffffff] Sep 9 01:35:50.540192 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 9 01:35:50.540202 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 9 01:35:50.540211 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Sep 9 01:35:50.540220 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 9 01:35:50.540232 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Sep 9 01:35:50.540242 kernel: ACPI: Added _OSI(Module Device) Sep 9 01:35:50.540251 kernel: ACPI: Added _OSI(Processor Device) Sep 9 01:35:50.540260 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 9 01:35:50.540269 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 9 01:35:50.540278 kernel: ACPI: Interpreter enabled Sep 9 01:35:50.540287 kernel: ACPI: PM: (supports S0 S5) Sep 9 01:35:50.540300 kernel: ACPI: Using IOAPIC for interrupt routing Sep 9 01:35:50.540309 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 9 01:35:50.540318 kernel: PCI: Ignoring E820 reservations for host bridge windows Sep 9 01:35:50.540328 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Sep 9 01:35:50.540337 kernel: iommu: Default domain type: Translated Sep 9 01:35:50.540346 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Sep 9 01:35:50.540355 kernel: efivars: Registered efivars operations Sep 9 01:35:50.540367 kernel: PCI: Using ACPI for IRQ routing Sep 9 01:35:50.540376 kernel: PCI: System does not support PCI Sep 9 01:35:50.540385 kernel: vgaarb: loaded Sep 9 01:35:50.540395 kernel: clocksource: Switched to clocksource tsc-early Sep 9 01:35:50.540404 kernel: VFS: Disk quotas dquot_6.6.0 Sep 9 01:35:50.540413 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 9 01:35:50.540423 kernel: pnp: PnP ACPI init Sep 9 01:35:50.540434 kernel: pnp: PnP ACPI: found 3 devices Sep 9 01:35:50.540443 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 9 01:35:50.540451 kernel: NET: Registered PF_INET protocol family Sep 9 01:35:50.540460 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) Sep 9 01:35:50.540468 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) Sep 9 01:35:50.540477 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 9 01:35:50.540486 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 9 01:35:50.540496 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Sep 9 01:35:50.540504 kernel: TCP: Hash tables configured (established 65536 bind 65536) Sep 9 01:35:50.540512 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) Sep 9 01:35:50.540520 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) Sep 9 01:35:50.540529 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 9 01:35:50.540536 kernel: NET: Registered PF_XDP protocol family Sep 9 01:35:50.540544 kernel: PCI: CLS 0 bytes, default 64 Sep 9 01:35:50.540556 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Sep 9 01:35:50.540565 kernel: software IO TLB: mapped [mem 0x000000003a96d000-0x000000003e96d000] (64MB) Sep 9 01:35:50.540575 kernel: RAPL PMU: API unit is 2^-32 Joules, 1 fixed counters, 10737418240 ms ovfl timer Sep 9 01:35:50.540584 kernel: RAPL PMU: hw unit of domain psys 2^-0 Joules Sep 9 01:35:50.540594 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212735223b2, max_idle_ns: 440795277976 ns Sep 9 01:35:50.540604 kernel: clocksource: Switched to clocksource tsc Sep 9 01:35:50.540614 kernel: Initialise system trusted keyrings Sep 9 01:35:50.540626 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 Sep 9 01:35:50.540665 kernel: Key type asymmetric registered Sep 9 01:35:50.540674 kernel: Asymmetric key parser 'x509' registered Sep 9 01:35:50.540683 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 9 01:35:50.540693 kernel: io scheduler mq-deadline registered Sep 9 01:35:50.540703 kernel: io scheduler kyber registered Sep 9 01:35:50.540713 kernel: io scheduler bfq registered Sep 9 01:35:50.540722 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Sep 9 01:35:50.540735 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 9 01:35:50.540754 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Sep 9 01:35:50.540766 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Sep 9 01:35:50.540775 kernel: serial8250: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A Sep 9 01:35:50.540785 kernel: ACPI: bus type drm_connector registered Sep 9 01:35:50.540794 kernel: i8042: PNP: No PS/2 controller found. Sep 9 01:35:50.540999 kernel: rtc_cmos 00:02: registered as rtc0 Sep 9 01:35:50.541134 kernel: rtc_cmos 00:02: setting system clock to 2026-09-09T01:35:46 UTC (1788917746) Sep 9 01:35:50.541259 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Sep 9 01:35:50.541271 kernel: intel_pstate: Intel P-state driver initializing Sep 9 01:35:50.541281 kernel: efifb: probing for efifb Sep 9 01:35:50.541291 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Sep 9 01:35:50.541302 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Sep 9 01:35:50.541312 kernel: efifb: scrolling: redraw Sep 9 01:35:50.541321 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Sep 9 01:35:50.541331 kernel: Console: switching to colour frame buffer device 128x48 Sep 9 01:35:50.541340 kernel: fb0: EFI VGA frame buffer device Sep 9 01:35:50.541350 kernel: pstore: Using crash dump compression: deflate Sep 9 01:35:50.541360 kernel: pstore: Registered efi_pstore as persistent store backend Sep 9 01:35:50.541369 kernel: NET: Registered PF_INET6 protocol family Sep 9 01:35:50.541380 kernel: Segment Routing with IPv6 Sep 9 01:35:50.541390 kernel: In-situ OAM (IOAM) with IPv6 Sep 9 01:35:50.541399 kernel: NET: Registered PF_PACKET protocol family Sep 9 01:35:50.541409 kernel: Key type dns_resolver registered Sep 9 01:35:50.541418 kernel: IPI shorthand broadcast: enabled Sep 9 01:35:50.541428 kernel: sched_clock: Marking stable (1949171879, 106269761)->(2350763859, -295322219) Sep 9 01:35:50.541437 kernel: registered taskstats version 1 Sep 9 01:35:50.541448 kernel: Loading compiled-in X.509 certificates Sep 9 01:35:50.541458 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.109-flatcar: 3200f9f68afc35408551543aa206c667cb82085c' Sep 9 01:35:50.541468 kernel: Demotion targets for Node 0: null Sep 9 01:35:50.541477 kernel: Key type .fscrypt registered Sep 9 01:35:50.541487 kernel: Key type fscrypt-provisioning registered Sep 9 01:35:50.541496 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 9 01:35:50.541505 kernel: ima: Allocated hash algorithm: sha1 Sep 9 01:35:50.541516 kernel: ima: No architecture policies found Sep 9 01:35:50.541526 kernel: clk: Disabling unused clocks Sep 9 01:35:50.541535 kernel: Freeing unused kernel image (initmem) memory: 16148K Sep 9 01:35:50.541545 kernel: Write protecting the kernel read-only data: 47104k Sep 9 01:35:50.541555 kernel: Freeing unused kernel image (rodata/data gap) memory: 108K Sep 9 01:35:50.541565 kernel: Run /init as init process Sep 9 01:35:50.541574 kernel: with arguments: Sep 9 01:35:50.541585 kernel: /init Sep 9 01:35:50.541594 kernel: with environment: Sep 9 01:35:50.541603 kernel: HOME=/ Sep 9 01:35:50.541612 kernel: TERM=linux Sep 9 01:35:50.541622 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Sep 9 01:35:50.541632 kernel: hv_vmbus: Vmbus version:5.3 Sep 9 01:35:50.541641 kernel: pps_core: LinuxPPS API ver. 1 registered Sep 9 01:35:50.541651 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 9 01:35:50.541662 kernel: PTP clock support registered Sep 9 01:35:50.541672 kernel: hv_utils: Registering HyperV Utility Driver Sep 9 01:35:50.541681 kernel: hv_vmbus: registering driver hv_utils Sep 9 01:35:50.541691 kernel: hv_utils: Shutdown IC version 3.2 Sep 9 01:35:50.541700 kernel: hv_utils: Heartbeat IC version 3.0 Sep 9 01:35:50.541710 kernel: hv_utils: TimeSync IC version 4.0 Sep 9 01:35:50.541719 kernel: SCSI subsystem initialized Sep 9 01:35:50.541730 kernel: hv_vmbus: registering driver hv_pci Sep 9 01:35:50.541915 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI VMBus probing: Using version 0x10004 Sep 9 01:35:50.542061 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI host bridge to bus c05b:00 Sep 9 01:35:50.542229 kernel: pci_bus c05b:00: root bus resource [mem 0xfc0000000-0xfc007ffff window] Sep 9 01:35:50.542380 kernel: pci_bus c05b:00: No busn resource found for root bus, will use [bus 00-ff] Sep 9 01:35:50.542562 kernel: pci c05b:00:00.0: [1414:00a9] type 00 class 0x010802 PCIe Endpoint Sep 9 01:35:50.542728 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit] Sep 9 01:35:50.545722 kernel: pci_bus c05b:00: busn_res: [bus 00-ff] end is updated to 00 Sep 9 01:35:50.545945 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit]: assigned Sep 9 01:35:50.545960 kernel: hv_vmbus: registering driver hv_storvsc Sep 9 01:35:50.546129 kernel: scsi host0: storvsc_host_t Sep 9 01:35:50.546313 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Sep 9 01:35:50.546326 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 9 01:35:50.546336 kernel: hv_vmbus: registering driver hid_hyperv Sep 9 01:35:50.546344 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Sep 9 01:35:50.546463 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Sep 9 01:35:50.546476 kernel: hv_vmbus: registering driver hyperv_keyboard Sep 9 01:35:50.546484 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 Sep 9 01:35:50.546635 kernel: nvme nvme0: pci function c05b:00:00.0 Sep 9 01:35:50.546790 kernel: nvme c05b:00:00.0: enabling device (0000 -> 0002) Sep 9 01:35:50.546904 kernel: nvme nvme0: 2/0/0 default/read/poll queues Sep 9 01:35:50.546914 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 9 01:35:50.547052 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Sep 9 01:35:50.547062 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 9 01:35:50.547196 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Sep 9 01:35:50.547210 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 9 01:35:50.547233 kernel: device-mapper: uevent: version 1.0.3 Sep 9 01:35:50.547244 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 9 01:35:50.547255 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Sep 9 01:35:50.547268 kernel: raid6: avx512x4 gen() 44223 MB/s Sep 9 01:35:50.547278 kernel: raid6: avx512x2 gen() 42880 MB/s Sep 9 01:35:50.547288 kernel: raid6: avx512x1 gen() 27583 MB/s Sep 9 01:35:50.547297 kernel: raid6: avx2x4 gen() 36821 MB/s Sep 9 01:35:50.547307 kernel: raid6: avx2x2 gen() 38572 MB/s Sep 9 01:35:50.547316 kernel: raid6: avx2x1 gen() 29967 MB/s Sep 9 01:35:50.547328 kernel: raid6: using algorithm avx512x4 gen() 44223 MB/s Sep 9 01:35:50.547337 kernel: raid6: .... xor() 7291 MB/s, rmw enabled Sep 9 01:35:50.547347 kernel: raid6: using avx512x2 recovery algorithm Sep 9 01:35:50.547356 kernel: xor: automatically using best checksumming function avx Sep 9 01:35:50.547365 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 9 01:35:50.547375 kernel: BTRFS: device fsid 7e197cdc-c9a9-48e3-8c0e-7f77f05de8af devid 1 transid 46 /dev/mapper/usr (254:0) scanned by mount (1024) Sep 9 01:35:50.547385 kernel: BTRFS info (device dm-0): first mount of filesystem 7e197cdc-c9a9-48e3-8c0e-7f77f05de8af Sep 9 01:35:50.547395 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Sep 9 01:35:50.547411 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Sep 9 01:35:50.547420 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Sep 9 01:35:50.547430 kernel: BTRFS info (device dm-0 state E): enabling free space tree Sep 9 01:35:50.547439 kernel: loop: module loaded Sep 9 01:35:50.547448 kernel: loop0: detected capacity change from 0 to 109608 Sep 9 01:35:50.547457 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 9 01:35:50.547468 systemd[1]: Successfully made /usr/ read-only. Sep 9 01:35:50.547484 systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Sep 9 01:35:50.547496 systemd[1]: Detected virtualization microsoft. Sep 9 01:35:50.547505 systemd[1]: Detected architecture x86-64. Sep 9 01:35:50.547514 systemd[1]: Running in initrd. Sep 9 01:35:50.547523 systemd[1]: Initializing machine ID from random generator. Sep 9 01:35:50.547537 systemd[1]: No hostname configured, using default hostname. Sep 9 01:35:50.547547 systemd[1]: Hostname set to . Sep 9 01:35:50.547559 (gene[1057]: '/usr/lib/systemd/system-generators/dracut-crypt-generator' failed with exit status 2. Sep 9 01:35:50.547570 systemd[1]: Queued start job for default target initrd.target. Sep 9 01:35:50.547581 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 01:35:50.547594 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 01:35:50.547606 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 9 01:35:50.547615 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 01:35:50.547626 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 9 01:35:50.547637 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 9 01:35:50.547650 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 9 01:35:50.547661 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 01:35:50.547672 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 01:35:50.547681 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 9 01:35:50.547692 systemd[1]: Reached target paths.target - Path Units. Sep 9 01:35:50.547702 systemd[1]: Reached target slices.target - Slice Units. Sep 9 01:35:50.547716 systemd[1]: Reached target swap.target - Swaps. Sep 9 01:35:50.547726 systemd[1]: Reached target timers.target - Timer Units. Sep 9 01:35:50.547735 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 01:35:50.549841 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 01:35:50.549860 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 9 01:35:50.549871 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 9 01:35:50.549881 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 9 01:35:50.549894 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 9 01:35:50.549903 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 9 01:35:50.549912 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 9 01:35:50.549921 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 01:35:50.549930 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 01:35:50.549940 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 01:35:50.549950 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Sep 9 01:35:50.549961 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 9 01:35:50.549970 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 01:35:50.549979 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 9 01:35:50.549988 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Sep 9 01:35:50.549997 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 01:35:50.550009 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 01:35:50.550018 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 01:35:50.550028 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 9 01:35:50.550037 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 01:35:50.550046 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 9 01:35:50.550086 systemd-journald[1150]: Collecting audit messages is enabled. Sep 9 01:35:50.550109 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 01:35:50.550118 kernel: audit: type=1130 audit(1788917750.529:2): 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' Sep 9 01:35:50.550130 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 01:35:50.550139 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 9 01:35:50.550151 systemd-journald[1150]: Journal started Sep 9 01:35:50.550172 systemd-journald[1150]: Runtime Journal (/run/log/journal/1b17f52467c243c9ad95fe8f3ab4a63e) is 8M, max 158.5M, 150.5M free. Sep 9 01:35:50.529000 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' Sep 9 01:35:50.382659 systemd-modules-load[1153]: Using 2 probe threads Sep 9 01:35:50.551000 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' Sep 9 01:35:50.556068 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 01:35:50.556146 kernel: audit: type=1130 audit(1788917750.551:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:50.557926 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 01:35:50.567062 systemd-tmpfiles[1163]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Sep 9 01:35:50.567135 systemd-tmpfiles[1163]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 9 01:35:50.574313 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 01:35:50.574834 kernel: Bridge firewalling registered Sep 9 01:35:50.574911 systemd-modules-load[1153]: Inserted module 'br_netfilter' Sep 9 01:35:50.577155 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 01:35:50.574000 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' Sep 9 01:35:50.576000 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' Sep 9 01:35:50.581601 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 01:35:50.583971 kernel: audit: type=1130 audit(1788917750.574:4): 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' Sep 9 01:35:50.583988 kernel: audit: type=1130 audit(1788917750.576:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:50.583000 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' Sep 9 01:35:50.587046 kernel: audit: type=1130 audit(1788917750.583:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:50.592732 systemd-vconsole-setup[1155]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 9 01:35:50.595492 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 01:35:50.599666 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 01:35:50.600000 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' Sep 9 01:35:50.605763 kernel: audit: type=1130 audit(1788917750.600:7): 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' Sep 9 01:35:50.605910 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 9 01:35:50.612912 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 9 01:35:50.614879 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 01:35:50.613000 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' Sep 9 01:35:50.613000 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' Sep 9 01:35:50.616000 audit: BPF prog-id=5 op=LOAD Sep 9 01:35:50.627326 kernel: audit: type=1130 audit(1788917750.613:8): 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' Sep 9 01:35:50.618855 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 01:35:50.627621 kernel: audit: type=1131 audit(1788917750.613:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:50.627638 kernel: audit: type=1334 audit(1788917750.616:10): prog-id=5 op=LOAD Sep 9 01:35:50.639866 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 01:35:50.641000 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' Sep 9 01:35:50.648908 kernel: audit: type=1130 audit(1788917750.641:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:50.647958 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 9 01:35:50.668761 dracut-cmdline[1183]: dracut-111 Sep 9 01:35:50.671631 systemd-resolved[1172]: Positive Trust Anchors: Sep 9 01:35:50.672783 systemd-resolved[1172]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 01:35:50.675589 dracut-cmdline[1183]: 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=8b01db594d78ebb1caee7895d3f2ad3faf1dafe1120cbd21e7a5a04ef4e9e018 Sep 9 01:35:50.672787 systemd-resolved[1172]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 9 01:35:50.672822 systemd-resolved[1172]: 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 Sep 9 01:35:50.698497 systemd-resolved[1172]: Defaulting to hostname 'linux'. Sep 9 01:35:50.716000 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' Sep 9 01:35:50.714998 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 01:35:50.717939 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 01:35:50.813826 kernel: Loading iSCSI transport class v2.0-870. Sep 9 01:35:50.873761 kernel: iscsi: registered transport (tcp) Sep 9 01:35:50.923085 kernel: iscsi: registered transport (qla4xxx) Sep 9 01:35:50.923144 kernel: QLogic iSCSI HBA Driver Sep 9 01:35:50.970195 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 9 01:35:50.989190 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 9 01:35:50.992000 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' Sep 9 01:35:50.994980 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 9 01:35:51.032897 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 9 01:35:51.031000 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' Sep 9 01:35:51.036188 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 9 01:35:51.039824 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 9 01:35:51.073437 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 9 01:35:51.075000 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' Sep 9 01:35:51.075000 audit: BPF prog-id=6 op=LOAD Sep 9 01:35:51.075000 audit: BPF prog-id=7 op=LOAD Sep 9 01:35:51.078317 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 01:35:51.138596 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 01:35:51.141000 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' Sep 9 01:35:51.187594 systemd-udevd[1422]: Using default interface naming scheme 'v260'. Sep 9 01:35:51.205302 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 01:35:51.209000 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' Sep 9 01:35:51.212866 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 9 01:35:51.213000 audit: BPF prog-id=8 op=LOAD Sep 9 01:35:51.219348 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 9 01:35:51.248391 dracut-pre-trigger[1532]: rd.md=0: removing MD RAID activation Sep 9 01:35:51.265158 systemd-networkd[1536]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Sep 9 01:35:51.276958 systemd-networkd[1536]: lo: Link UP Sep 9 01:35:51.276961 systemd-networkd[1536]: lo: Gained carrier Sep 9 01:35:51.278000 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' Sep 9 01:35:51.277635 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 01:35:51.281000 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' Sep 9 01:35:51.279941 systemd[1]: Started systemd-networkd.service - Network Management. Sep 9 01:35:51.283108 systemd[1]: Reached target network.target - Network. Sep 9 01:35:51.288084 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 01:35:51.358482 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 01:35:51.362000 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' Sep 9 01:35:51.366586 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 9 01:35:51.468515 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 01:35:51.470000 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' Sep 9 01:35:51.474351 kernel: cryptd: max_cpu_qlen set to 1000 Sep 9 01:35:51.468626 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 01:35:51.471865 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 01:35:51.477344 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 01:35:51.517107 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 01:35:51.517000 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' Sep 9 01:35:51.517000 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' Sep 9 01:35:51.517202 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 01:35:51.527020 kernel: hv_vmbus: registering driver hv_netvsc Sep 9 01:35:51.527055 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#58 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Sep 9 01:35:51.531883 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 01:35:51.542263 kernel: hv_netvsc f8615163-0000-1000-2000-7c1e52774ee8 (unnamed net_device) (uninitialized): VF slot 1 added Sep 9 01:35:51.559778 kernel: AES CTR mode by8 optimization enabled Sep 9 01:35:51.574131 systemd-vconsole-setup[1613]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 9 01:35:51.582446 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 01:35:51.586000 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' Sep 9 01:35:51.590271 systemd-networkd[1536]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 9 01:35:51.590275 systemd-networkd[1536]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 01:35:51.592068 systemd-networkd[1536]: eth0: Link UP Sep 9 01:35:51.592209 systemd-networkd[1536]: eth0: Gained carrier Sep 9 01:35:51.592221 systemd-networkd[1536]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 9 01:35:51.607793 systemd-networkd[1536]: eth0: DHCPv4 address 10.0.0.22/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 9 01:35:51.712786 kernel: nvme nvme0: using unchecked data buffer Sep 9 01:35:51.814712 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - MSFT NVMe Accelerator v1.0 USR-A. Sep 9 01:35:51.821407 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 9 01:35:51.905448 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Sep 9 01:35:51.916270 systemd[1]: Mounting oem.mount - /oem... Sep 9 01:35:51.942164 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - MSFT NVMe Accelerator v1.0 EFI-SYSTEM. Sep 9 01:35:51.955699 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - MSFT NVMe Accelerator v1.0 ROOT. Sep 9 01:35:51.971805 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1725) Sep 9 01:35:51.974247 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem b560603b-762b-48b5-acad-ee47f15907af Sep 9 01:35:51.978759 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Sep 9 01:35:52.014770 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 9 01:35:52.014809 kernel: BTRFS info (device nvme0n1p6): turning on async discard Sep 9 01:35:52.014822 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 9 01:35:52.019542 systemd[1]: Mounted oem.mount - /oem. Sep 9 01:35:52.034971 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 9 01:35:52.066681 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 9 01:35:52.068000 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' Sep 9 01:35:52.071220 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 01:35:52.073108 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 01:35:52.077402 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 01:35:52.090488 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 9 01:35:52.153915 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 9 01:35:52.156000 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' Sep 9 01:35:52.565944 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 Sep 9 01:35:52.569465 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 Sep 9 01:35:52.569721 kernel: pci_bus 7870:00: root bus resource [mem 0xfc2000000-0xfc4007fff window] Sep 9 01:35:52.571047 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] Sep 9 01:35:52.576793 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint Sep 9 01:35:52.580812 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref] Sep 9 01:35:52.585841 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref] Sep 9 01:35:52.588010 kernel: pci 7870:00:00.0: enabling Extended Tags Sep 9 01:35:52.603123 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 Sep 9 01:35:52.603350 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref]: assigned Sep 9 01:35:52.606833 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref]: assigned Sep 9 01:35:52.668603 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) Sep 9 01:35:52.681759 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 Sep 9 01:35:52.685099 kernel: hv_netvsc f8615163-0000-1000-2000-7c1e52774ee8 eth0: VF registering: eth1 Sep 9 01:35:52.685503 kernel: mana 7870:00:00.0 eth1: joined to eth0 Sep 9 01:35:52.690362 systemd-networkd[1536]: eth1: Interface name change detected, renamed to enP30832s1. Sep 9 01:35:52.691955 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 Sep 9 01:35:52.788760 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Sep 9 01:35:52.791758 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Sep 9 01:35:52.792156 kernel: hv_netvsc f8615163-0000-1000-2000-7c1e52774ee8 eth0: Data path switched to VF: enP30832s1 Sep 9 01:35:52.793456 systemd-networkd[1536]: enP30832s1: Link UP Sep 9 01:35:52.793635 systemd-networkd[1536]: enP30832s1: Gained carrier Sep 9 01:35:53.155037 disk-uuid[1721]: Warning: The kernel is still using the old partition table. Sep 9 01:35:53.155037 disk-uuid[1721]: The new table will be used at the next reboot or after you Sep 9 01:35:53.155037 disk-uuid[1721]: run partprobe(8) or kpartx(8) Sep 9 01:35:53.155037 disk-uuid[1721]: The operation has completed successfully. Sep 9 01:35:53.164885 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 9 01:35:53.165016 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 9 01:35:53.167000 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' Sep 9 01:35:53.167000 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' Sep 9 01:35:53.170214 systemd[1]: Mounting boot.mount - Boot partition... Sep 9 01:35:53.212120 ignition[1759]: Ignition 2.24.0 Sep 9 01:35:53.212133 ignition[1759]: Stage: fetch-offline Sep 9 01:35:53.217000 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' Sep 9 01:35:53.214625 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 01:35:53.212535 ignition[1759]: no config dir at "/usr/lib/ignition/base.d" Sep 9 01:35:53.220884 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 9 01:35:53.212546 ignition[1759]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 9 01:35:53.212631 ignition[1759]: parsed url from cmdline: "" Sep 9 01:35:53.212634 ignition[1759]: no config URL provided Sep 9 01:35:53.212639 ignition[1759]: reading system config file "/usr/lib/ignition/user.ign" Sep 9 01:35:53.212654 ignition[1759]: no config at "/usr/lib/ignition/user.ign" Sep 9 01:35:53.212659 ignition[1759]: failed to fetch config: resource requires networking Sep 9 01:35:53.212835 ignition[1759]: Ignition finished successfully Sep 9 01:35:53.245287 systemd[1]: Mounted boot.mount - Boot partition. Sep 9 01:35:53.245834 ignition[1794]: Ignition 2.24.0 Sep 9 01:35:53.245840 ignition[1794]: Stage: fetch Sep 9 01:35:53.246035 ignition[1794]: no config dir at "/usr/lib/ignition/base.d" Sep 9 01:35:53.246042 ignition[1794]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 9 01:35:53.246110 ignition[1794]: parsed url from cmdline: "" Sep 9 01:35:53.246113 ignition[1794]: no config URL provided Sep 9 01:35:53.246117 ignition[1794]: reading system config file "/usr/lib/ignition/user.ign" Sep 9 01:35:53.246125 ignition[1794]: no config at "/usr/lib/ignition/user.ign" Sep 9 01:35:53.246142 ignition[1794]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Sep 9 01:35:53.318271 ignition[1794]: GET result: OK Sep 9 01:35:53.318308 ignition[1794]: failed to retrieve userdata from IMDS, falling back to custom data: not a config (empty) Sep 9 01:35:53.345861 systemd-networkd[1536]: eth0: Gained IPv6LL Sep 9 01:35:53.345978 ignition[1794]: opening config device: "/dev/sr0" Sep 9 01:35:53.347860 ignition[1794]: getting drive status for "/dev/sr0" Sep 9 01:35:53.347924 ignition[1794]: drive status: OK Sep 9 01:35:53.347987 ignition[1794]: mounting config device Sep 9 01:35:53.347995 ignition[1794]: op(1): [started] mounting "/dev/sr0" at "/tmp/ignition-azure1337551485" Sep 9 01:35:53.360490 ignition[1794]: op(1): [finished] mounting "/dev/sr0" at "/tmp/ignition-azure1337551485" Sep 9 01:35:53.362711 ignition[1794]: checking for config drive Sep 9 01:35:53.362814 kernel: UDF-fs: INFO Mounting volume 'UDF Volume', timestamp 2026/09/10 00:00 (1000) Sep 9 01:35:53.362982 ignition[1794]: reading config Sep 9 01:35:53.363004 ignition[1794]: op(2): [started] unmounting "/dev/sr0" at "/tmp/ignition-azure1337551485" Sep 9 01:35:53.363758 ignition[1794]: op(2): [finished] unmounting "/dev/sr0" at "/tmp/ignition-azure1337551485" Sep 9 01:35:53.363779 ignition[1794]: config has been read from custom data Sep 9 01:35:53.365673 systemd[1]: tmp-ignition\x2dazure1337551485.mount: Deactivated successfully. Sep 9 01:35:53.363792 ignition[1794]: parsing config with SHA512: cf83e1357eefb8bdf1542850d66d8007d620e4050b5715dc83f4a921d36ce9ce47d0d13c5d85f2b0ff8318d2877eec2f63b931bd47417a81a538327af927da3e Sep 9 01:35:53.366622 unknown[1794]: fetched base config from "system" Sep 9 01:35:53.371000 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' Sep 9 01:35:53.363800 ignition[1794]: not a config (empty): provider config was empty, continuing with empty cache config Sep 9 01:35:53.366628 unknown[1794]: fetched base config from "system" Sep 9 01:35:53.366736 ignition[1794]: fetch: fetch complete Sep 9 01:35:53.368832 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 9 01:35:53.366756 ignition[1794]: fetch: fetch passed Sep 9 01:35:53.374122 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 9 01:35:53.366790 ignition[1794]: Ignition finished successfully Sep 9 01:35:53.395017 ignition[1803]: Ignition 2.24.0 Sep 9 01:35:53.395029 ignition[1803]: Stage: kargs Sep 9 01:35:53.397068 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 9 01:35:53.398000 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' Sep 9 01:35:53.395225 ignition[1803]: no config dir at "/usr/lib/ignition/base.d" Sep 9 01:35:53.400983 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 9 01:35:53.395231 ignition[1803]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 9 01:35:53.395657 ignition[1803]: kargs: kargs passed Sep 9 01:35:53.395690 ignition[1803]: Ignition finished successfully Sep 9 01:35:53.449312 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 9 01:35:53.449408 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 9 01:35:53.450000 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' Sep 9 01:35:53.452576 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 9 01:35:53.453000 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' Sep 9 01:35:53.452666 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 9 01:35:53.455685 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 9 01:35:53.455807 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 01:35:53.460000 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' Sep 9 01:35:53.462279 systemd[1]: Unmounting oem.mount - /oem... Sep 9 01:35:53.481784 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem b560603b-762b-48b5-acad-ee47f15907af Sep 9 01:35:53.482358 systemd[1]: oem.mount: Deactivated successfully. Sep 9 01:35:53.482474 systemd[1]: Unmounted oem.mount - /oem. Sep 9 01:35:53.507888 ignition[1813]: Ignition 2.24.0 Sep 9 01:35:53.507899 ignition[1813]: Stage: disks Sep 9 01:35:53.510000 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' Sep 9 01:35:53.509928 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 9 01:35:53.508113 ignition[1813]: no config dir at "/usr/lib/ignition/base.d" Sep 9 01:35:53.511874 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 9 01:35:53.508120 ignition[1813]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 9 01:35:53.513109 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 9 01:35:53.508550 ignition[1813]: disks: disks passed Sep 9 01:35:53.516471 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 01:35:53.508581 ignition[1813]: Ignition finished successfully Sep 9 01:35:53.521257 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 01:35:53.524097 systemd[1]: Reached target basic.target - Basic System. Sep 9 01:35:53.527835 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 9 01:35:53.638169 systemd-fsck[1823]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Sep 9 01:35:53.643858 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 9 01:35:53.643000 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' Sep 9 01:35:53.647880 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 9 01:35:53.951759 kernel: EXT4-fs (nvme0n1p9): mounted filesystem cf90976e-5b98-45ff-add6-9743e1ca0149 r/w with ordered data mode. Quota mode: none. Sep 9 01:35:53.952326 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 9 01:35:53.956199 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 9 01:35:53.973186 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 9 01:35:53.978655 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Sep 9 01:35:53.979196 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Sep 9 01:35:53.979234 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 01:35:53.992047 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 9 01:35:53.997102 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 9 01:35:54.382251 systemd-tmpfiles[1852]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:1: Duplicate line for path "/sysroot/var", ignoring. Sep 9 01:35:54.382286 systemd-tmpfiles[1852]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:7: Duplicate line for path "/sysroot/var/empty", ignoring. Sep 9 01:35:54.382383 systemd-tmpfiles[1852]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:28: Duplicate line for path "/sysroot/var/log", ignoring. Sep 9 01:35:54.552137 coreos-metadata[1833]: Sep 09 01:35:54.552 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Sep 9 01:35:54.560459 coreos-metadata[1833]: Sep 09 01:35:54.560 INFO Fetch successful Sep 9 01:35:54.561726 coreos-metadata[1833]: Sep 09 01:35:54.560 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Sep 9 01:35:54.573725 coreos-metadata[1833]: Sep 09 01:35:54.573 INFO Fetch successful Sep 9 01:35:54.576837 coreos-metadata[1833]: Sep 09 01:35:54.574 INFO wrote hostname ci-4790.0.0-n-b349b5973d to /sysroot/etc/hostname Sep 9 01:35:54.576912 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 9 01:35:54.579000 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' Sep 9 01:35:55.410766 kernel: loop1: detected capacity change from 0 to 44472 Sep 9 01:35:55.444992 kernel: loop1: p1 p2 p3 Sep 9 01:35:55.810798 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:55.813739 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:35:55.813791 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:35:55.814991 systemd-confext[1911]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Sep 9 01:35:55.818885 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:35:55.853773 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:55.928767 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Sep 9 01:35:55.942763 kernel: loop2: detected capacity change from 0 to 44472 Sep 9 01:35:55.950765 kernel: loop2: p1 p2 p3 Sep 9 01:35:55.957537 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:55.957585 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:35:55.962262 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:35:55.962296 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:35:55.962296 (sd-merge)[1922]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Sep 9 01:35:55.966072 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:55.983629 (sd-merge)[1922]: Using extensions '00-flatcar-default.raw'. Sep 9 01:35:55.985212 (sd-merge)[1922]: Merged extensions into '/sysroot/etc'. Sep 9 01:35:55.988818 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Sep 9 01:35:55.989872 initrd-setup-root[1929]: /etc 00-flatcar-default Wed 2026-09-09 01:35:50 UTC Sep 9 01:35:55.991624 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 9 01:35:55.993000 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' Sep 9 01:35:55.999894 kernel: kauditd_printk_skb: 29 callbacks suppressed Sep 9 01:35:55.999288 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 9 01:35:56.004838 kernel: audit: type=1130 audit(1788917755.993: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' Sep 9 01:35:56.032282 ignition[1933]: INFO : Ignition 2.24.0 Sep 9 01:35:56.032282 ignition[1933]: INFO : Stage: mount Sep 9 01:35:56.035214 ignition[1933]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 9 01:35:56.035214 ignition[1933]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 9 01:35:56.035214 ignition[1933]: INFO : mount: mount passed Sep 9 01:35:56.035214 ignition[1933]: INFO : Ignition finished successfully Sep 9 01:35:56.037000 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' Sep 9 01:35:56.034478 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 9 01:35:56.049631 kernel: audit: type=1130 audit(1788917756.037:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:56.042848 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 9 01:35:56.055200 systemd[1]: Mounting oem.mount - /oem... Sep 9 01:35:56.068796 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1941) Sep 9 01:35:56.071763 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem b560603b-762b-48b5-acad-ee47f15907af Sep 9 01:35:56.071797 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Sep 9 01:35:56.076137 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 9 01:35:56.076232 kernel: BTRFS info (device nvme0n1p6): turning on async discard Sep 9 01:35:56.077020 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 9 01:35:56.078820 systemd[1]: Mounted oem.mount - /oem. Sep 9 01:35:56.082057 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 01:35:56.097323 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 01:35:56.124697 ignition[1959]: INFO : Ignition 2.24.0 Sep 9 01:35:56.124697 ignition[1959]: INFO : Stage: files Sep 9 01:35:56.128974 ignition[1959]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 9 01:35:56.128974 ignition[1959]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 9 01:35:56.128974 ignition[1959]: DEBUG : files: compiled without relabeling support, skipping Sep 9 01:35:56.128974 ignition[1959]: INFO : files: createResultFile: createFiles: op(1): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 9 01:35:56.128974 ignition[1959]: INFO : files: createResultFile: createFiles: op(1): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 9 01:35:56.128974 ignition[1959]: INFO : files: files passed Sep 9 01:35:56.128974 ignition[1959]: INFO : Ignition finished successfully Sep 9 01:35:56.127000 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' Sep 9 01:35:56.148000 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' Sep 9 01:35:56.127133 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 9 01:35:56.152000 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' Sep 9 01:35:56.157976 kernel: audit: type=1130 audit(1788917756.127:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:56.135142 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 9 01:35:56.159845 kernel: audit: type=1130 audit(1788917756.148:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:56.142144 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 9 01:35:56.162467 kernel: audit: type=1131 audit(1788917756.152: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' Sep 9 01:35:56.150258 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 9 01:35:56.150351 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 9 01:35:56.178998 initrd-setup-root-after-ignition[1983]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 01:35:56.178998 initrd-setup-root-after-ignition[1983]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 9 01:35:56.184827 initrd-setup-root-after-ignition[1987]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 01:35:56.188759 kernel: loop3: detected capacity change from 0 to 44472 Sep 9 01:35:56.195882 kernel: loop3: p1 p2 p3 Sep 9 01:35:56.204090 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:56.204125 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:35:56.207476 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:35:56.207511 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:35:56.207552 systemd-confext[1989]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Sep 9 01:35:56.217783 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:56.237761 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Sep 9 01:35:56.259772 kernel: loop4: detected capacity change from 0 to 44472 Sep 9 01:35:56.267762 kernel: loop4: p1 p2 p3 Sep 9 01:35:56.275190 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:56.278180 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:35:56.278212 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:35:56.283469 (sd-merge)[1997]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Sep 9 01:35:56.287420 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:35:56.289814 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:56.303458 (sd-merge)[1997]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 9 01:35:56.305845 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Sep 9 01:35:56.382777 kernel: loop4: detected capacity change from 0 to 404728 Sep 9 01:35:56.474757 kernel: loop4: p1 p2 p3 Sep 9 01:35:56.847803 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:56.850664 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:35:56.850705 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:35:56.851923 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:35:56.851982 systemd-sysext[2005]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Sep 9 01:35:56.856483 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:57.006767 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 9 01:35:57.136787 kernel: loop5: detected capacity change from 0 to 183704 Sep 9 01:35:57.171764 kernel: loop5: p1 p2 p3 Sep 9 01:35:57.364998 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:57.365067 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:35:57.366609 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:35:57.368208 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:35:57.368238 systemd-sysext[2005]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Sep 9 01:35:57.371853 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:57.508823 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 9 01:35:57.555774 kernel: loop6: detected capacity change from 0 to 137288 Sep 9 01:35:57.595767 kernel: loop6: p1 p2 p3 Sep 9 01:35:57.876498 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:57.880839 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:35:57.880888 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:35:57.880907 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:35:57.881526 systemd-sysext[2005]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Sep 9 01:35:57.887449 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:58.026764 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 9 01:35:58.059909 kernel: loop7: detected capacity change from 0 to 404728 Sep 9 01:35:58.071758 kernel: loop7: p1 p2 p3 Sep 9 01:35:58.082373 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:58.082416 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:35:58.084428 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:35:58.085326 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:35:58.085813 (sd-merge)[2028]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Sep 9 01:35:58.091762 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:58.124766 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 9 01:35:58.128777 kernel: loop1: detected capacity change from 0 to 183704 Sep 9 01:35:58.137761 kernel: loop1: p1 p2 p3 Sep 9 01:35:58.145586 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:58.145615 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:35:58.147094 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:35:58.148243 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:35:58.148345 (sd-merge)[2028]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Sep 9 01:35:58.151866 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:58.174760 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Sep 9 01:35:58.176770 kernel: loop3: detected capacity change from 0 to 137288 Sep 9 01:35:58.188801 kernel: loop3: p1 p2 p3 Sep 9 01:35:58.196286 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:58.196328 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:35:58.200320 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:35:58.200352 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:35:58.201254 (sd-merge)[2028]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Sep 9 01:35:58.207483 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:35:58.229578 (sd-merge)[2028]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4790.0.0+nightly-20260908-2100.raw'. Sep 9 01:35:58.232283 (sd-merge)[2028]: Merged extensions into '/sysroot/usr'. Sep 9 01:35:58.235835 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Sep 9 01:35:58.235373 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 01:35:58.236000 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' Sep 9 01:35:58.241202 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 9 01:35:58.245169 kernel: audit: type=1130 audit(1788917758.236:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:58.262000 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 9 01:35:58.262115 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 9 01:35:58.264000 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' Sep 9 01:35:58.264000 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' Sep 9 01:35:58.272788 kernel: audit: type=1130 audit(1788917758.264:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:58.265833 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Sep 9 01:35:58.274863 kernel: audit: type=1131 audit(1788917758.264:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:58.266007 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 9 01:35:58.276334 systemd[1]: Starting dracut-mount.service - dracut mount hook... Sep 9 01:35:58.528381 systemd[1]: Finished dracut-mount.service - dracut mount hook. Sep 9 01:35:58.530000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:58.534904 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 9 01:35:58.540626 kernel: audit: type=1130 audit(1788917758.530:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:58.555629 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 01:35:58.558000 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' Sep 9 01:35:58.561874 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 9 01:35:58.568834 kernel: audit: type=1130 audit(1788917758.558:50): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:58.584296 systemd[1]: Stopped target basic.target - Basic System. Sep 9 01:35:58.584657 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 01:35:58.589961 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 9 01:35:58.592378 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 9 01:35:58.593853 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 9 01:35:58.596681 systemd[1]: Stopped target paths.target - Path Units. Sep 9 01:35:58.600884 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 01:35:58.603457 systemd[1]: Stopped target slices.target - Slice Units. Sep 9 01:35:58.606894 systemd[1]: Stopped target sockets.target - Socket Units. Sep 9 01:35:58.610937 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 9 01:35:58.613422 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 9 01:35:58.615862 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Sep 9 01:35:58.619911 systemd[1]: Stopped target swap.target - Swaps. Sep 9 01:35:58.623894 systemd[1]: Stopped target timers.target - Timer Units. Sep 9 01:35:58.624342 systemd[1]: iscsid.socket: Deactivated successfully. Sep 9 01:35:58.624433 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 01:35:58.624624 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 9 01:35:58.624684 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 01:35:58.636895 systemd[1]: systemd-coredump.socket: Deactivated successfully. Sep 9 01:35:58.636980 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Sep 9 01:35:58.640000 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' Sep 9 01:35:58.640883 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Sep 9 01:35:58.640960 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Sep 9 01:35:58.652000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:35:58.641679 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 9 01:35:58.656000 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' Sep 9 01:35:58.641809 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 01:35:58.642066 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 9 01:35:58.642342 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 01:35:58.649879 systemd[1]: dracut-mount.service: Deactivated successfully. Sep 9 01:35:58.649991 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Sep 9 01:35:58.653911 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 9 01:35:58.654002 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 9 01:35:58.658001 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 9 01:35:58.661882 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 9 01:35:58.662205 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 01:35:58.665419 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 01:35:58.668156 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 9 01:35:58.668395 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 01:35:58.671019 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 9 01:35:58.671124 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 9 01:35:58.687000 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' Sep 9 01:35:58.688910 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 9 01:35:58.689017 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 01:35:58.691000 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' Sep 9 01:35:58.693314 systemd[1]: ignition-files.service: Deactivated successfully. Sep 9 01:35:58.694462 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 9 01:35:58.695000 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' Sep 9 01:35:58.696949 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Sep 9 01:35:58.699000 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' Sep 9 01:35:58.697050 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 9 01:35:58.703000 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' Sep 9 01:35:58.703000 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' Sep 9 01:35:58.704000 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' Sep 9 01:35:58.702328 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 9 01:35:58.712000 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' Sep 9 01:35:58.705040 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 9 01:35:58.705203 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 9 01:35:58.705396 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 9 01:35:58.705503 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 01:35:58.723000 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' Sep 9 01:35:58.723000 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' Sep 9 01:35:58.705673 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 9 01:35:58.705785 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 01:35:58.706034 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 9 01:35:58.735364 ignition[2070]: INFO : Ignition 2.24.0 Sep 9 01:35:58.735364 ignition[2070]: INFO : Stage: umount Sep 9 01:35:58.735364 ignition[2070]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 9 01:35:58.735364 ignition[2070]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 9 01:35:58.735364 ignition[2070]: INFO : umount: umount passed Sep 9 01:35:58.735364 ignition[2070]: INFO : Ignition finished successfully Sep 9 01:35:58.735000 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' Sep 9 01:35:58.706301 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 01:35:58.748000 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' Sep 9 01:35:58.719306 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 9 01:35:58.751000 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' Sep 9 01:35:58.751000 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' Sep 9 01:35:58.719403 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 9 01:35:58.734958 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 9 01:35:58.735071 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 9 01:35:58.761000 audit: BPF prog-id=5 op=UNLOAD Sep 9 01:35:58.737584 systemd[1]: Stopped target network.target - Network. Sep 9 01:35:58.763000 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' Sep 9 01:35:58.742997 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 9 01:35:58.743986 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 9 01:35:58.771000 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' Sep 9 01:35:58.749831 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 9 01:35:58.774000 audit: BPF prog-id=8 op=UNLOAD Sep 9 01:35:58.749860 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 9 01:35:58.752141 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 9 01:35:58.752171 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 9 01:35:58.752613 systemd[1]: Stopping systemd-networkd.service - Network Management... Sep 9 01:35:58.789000 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' Sep 9 01:35:58.752838 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 9 01:35:58.759786 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 9 01:35:58.759912 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 9 01:35:58.766976 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 9 01:35:58.767075 systemd[1]: Stopped systemd-networkd.service - Network Management. Sep 9 01:35:58.775908 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Sep 9 01:35:58.775986 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 9 01:35:58.779816 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 9 01:35:58.783786 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 9 01:35:58.783822 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Sep 9 01:35:58.786810 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 9 01:35:58.790945 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 9 01:35:58.790988 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 01:35:58.824000 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' Sep 9 01:35:58.791305 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 01:35:58.832000 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' Sep 9 01:35:58.835694 kernel: hv_netvsc f8615163-0000-1000-2000-7c1e52774ee8 eth0: Data path switched from VF: enP30832s1 Sep 9 01:35:58.819613 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 9 01:35:58.835000 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' Sep 9 01:35:58.838315 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Sep 9 01:35:58.821445 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 01:35:58.838000 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' Sep 9 01:35:58.826222 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 9 01:35:58.826262 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 9 01:35:58.828368 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 9 01:35:58.828513 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 9 01:35:58.834101 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 9 01:35:58.834135 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 9 01:35:58.836208 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 9 01:35:58.836240 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 01:35:58.846423 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 9 01:35:58.853514 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 9 01:35:58.853558 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 9 01:35:58.855365 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 9 01:35:58.855396 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 01:35:58.855794 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 9 01:35:58.855813 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 01:35:58.856042 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 9 01:35:58.856060 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 01:35:58.856091 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 01:35:58.856111 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 01:35:58.856684 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 9 01:35:58.853000 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' Sep 9 01:35:58.853000 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' Sep 9 01:35:58.854000 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' Sep 9 01:35:58.854000 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' Sep 9 01:35:58.854000 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' Sep 9 01:35:58.855000 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' Sep 9 01:35:58.857704 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 9 01:35:58.893085 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 9 01:35:58.893925 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 9 01:35:58.897000 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' Sep 9 01:35:58.897000 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' Sep 9 01:35:58.899071 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 9 01:35:58.903863 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 9 01:35:58.917699 systemd[1]: Switching root. Sep 9 01:35:59.150828 systemd-journald[1150]: Journal stopped Sep 9 01:36:13.002314 systemd-journald[1150]: Received SIGTERM from PID 1 (systemd). Sep 9 01:36:13.002346 kernel: SELinux: policy capability network_peer_controls=1 Sep 9 01:36:13.002359 kernel: SELinux: policy capability open_perms=1 Sep 9 01:36:13.002369 kernel: SELinux: policy capability extended_socket_class=1 Sep 9 01:36:13.002380 kernel: SELinux: policy capability always_check_network=0 Sep 9 01:36:13.002389 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 9 01:36:13.002400 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 9 01:36:13.002410 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 9 01:36:13.002419 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 9 01:36:13.002428 kernel: SELinux: policy capability userspace_initial_context=0 Sep 9 01:36:13.002440 systemd[1]: Successfully loaded SELinux policy in 358.238ms. Sep 9 01:36:13.002451 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.463ms. Sep 9 01:36:13.002463 systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Sep 9 01:36:13.002474 systemd[1]: Detected virtualization microsoft. Sep 9 01:36:13.002487 systemd[1]: Detected architecture x86-64. Sep 9 01:36:13.002497 systemd[1]: Detected first boot. Sep 9 01:36:13.002508 systemd[1]: Initializing machine ID from random generator. Sep 9 01:36:13.002519 systemd[1]: Hostname set to . Sep 9 01:36:13.002530 kernel: kauditd_printk_skb: 36 callbacks suppressed Sep 9 01:36:13.002542 kernel: audit: type=1334 audit(1788917764.667:87): prog-id=9 op=LOAD Sep 9 01:36:13.002552 kernel: audit: type=1334 audit(1788917764.667:88): prog-id=9 op=UNLOAD Sep 9 01:36:13.002563 zram_generator::config[2111]: No configuration found. Sep 9 01:36:13.002575 kernel: Guest personality initialized and is inactive Sep 9 01:36:13.002584 kernel: VMCI host device registered (name=vmci, major=10, minor=259) Sep 9 01:36:13.002595 kernel: Initialized host personality Sep 9 01:36:13.002606 kernel: NET: Registered PF_VSOCK protocol family Sep 9 01:36:13.002615 systemd[1]: Applying preset policy. Sep 9 01:36:13.002630 systemd[1]: Created symlink '/etc/systemd/system/timers.target.wants/google-oslogin-cache.timer' → '/usr/lib/systemd/system/google-oslogin-cache.timer'. Sep 9 01:36:13.002641 systemd[1]: Populated /etc with preset unit settings. Sep 9 01:36:13.002652 kernel: audit: type=1334 audit(1788917771.772:89): prog-id=10 op=LOAD Sep 9 01:36:13.002661 kernel: audit: type=1334 audit(1788917771.772:90): prog-id=2 op=UNLOAD Sep 9 01:36:13.002671 kernel: audit: type=1334 audit(1788917771.772:91): prog-id=11 op=LOAD Sep 9 01:36:13.002683 kernel: audit: type=1334 audit(1788917771.772:92): prog-id=12 op=LOAD Sep 9 01:36:13.002692 kernel: audit: type=1334 audit(1788917771.772:93): prog-id=3 op=UNLOAD Sep 9 01:36:13.002702 kernel: audit: type=1334 audit(1788917771.772:94): prog-id=4 op=UNLOAD Sep 9 01:36:13.002712 kernel: audit: type=1334 audit(1788917771.773:95): prog-id=13 op=LOAD Sep 9 01:36:13.002721 kernel: audit: type=1334 audit(1788917771.773:96): prog-id=10 op=UNLOAD Sep 9 01:36:13.002731 kernel: audit: type=1334 audit(1788917771.773:97): prog-id=14 op=LOAD Sep 9 01:36:13.002749 kernel: audit: type=1334 audit(1788917771.773:98): prog-id=15 op=LOAD Sep 9 01:36:13.002763 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 9 01:36:13.002776 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 9 01:36:13.002787 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 9 01:36:13.002800 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 9 01:36:13.002811 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 9 01:36:13.002822 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 9 01:36:13.002835 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 9 01:36:13.002846 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 9 01:36:13.002857 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 9 01:36:13.002868 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 9 01:36:13.002879 systemd[1]: Created slice user.slice - User and Session Slice. Sep 9 01:36:13.002890 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 01:36:13.002903 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 01:36:13.002914 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 9 01:36:13.002925 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 9 01:36:13.002936 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 9 01:36:13.002947 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 01:36:13.002959 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Sep 9 01:36:13.002971 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 9 01:36:13.002982 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 01:36:13.002992 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 01:36:13.003003 systemd[1]: Reached target imports.target - Image Downloads. Sep 9 01:36:13.003013 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 9 01:36:13.003022 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 9 01:36:13.003032 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 9 01:36:13.003043 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 9 01:36:13.003052 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 01:36:13.003062 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 01:36:13.003072 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Sep 9 01:36:13.003083 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Sep 9 01:36:13.003093 systemd[1]: Reached target slices.target - Slice Units. Sep 9 01:36:13.003103 systemd[1]: Reached target swap.target - Swaps. Sep 9 01:36:13.003113 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 9 01:36:13.003122 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 9 01:36:13.003132 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 9 01:36:13.003143 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 9 01:36:13.003153 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Sep 9 01:36:13.003163 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 9 01:36:13.003173 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Sep 9 01:36:13.003182 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Sep 9 01:36:13.003192 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Sep 9 01:36:13.003203 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Sep 9 01:36:13.003218 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 9 01:36:13.003229 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Sep 9 01:36:13.003240 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Sep 9 01:36:13.003251 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Sep 9 01:36:13.003263 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Sep 9 01:36:13.003275 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Sep 9 01:36:13.003287 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 01:36:13.003298 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Sep 9 01:36:13.003309 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 9 01:36:13.003321 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 9 01:36:13.003332 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 9 01:36:13.003343 systemd[1]: Mounting media.mount - External Media Directory... Sep 9 01:36:13.003353 systemd[1]: proc-xen.mount - /proc/xen skipped, unmet condition check ConditionVirtualization=xen Sep 9 01:36:13.003367 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 9 01:36:13.003379 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 9 01:36:13.003391 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Sep 9 01:36:13.003401 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 9 01:36:13.003412 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 9 01:36:13.003424 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Sep 9 01:36:13.003436 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 01:36:13.003449 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 9 01:36:13.003461 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Sep 9 01:36:13.003472 systemd[1]: modprobe@efi_pstore.service - Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore Sep 9 01:36:13.003483 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 9 01:36:13.003495 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Sep 9 01:36:13.003506 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 9 01:36:13.003519 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 9 01:36:13.003530 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 Sep 9 01:36:13.003542 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 01:36:13.003553 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 01:36:13.003565 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 9 01:36:13.003576 systemd[1]: Reached target time-set.target - System Time Set. Sep 9 01:36:13.003587 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 9 01:36:13.003600 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 9 01:36:13.003612 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 01:36:13.003624 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer skipped, unmet condition check ConditionVirtualization=xen Sep 9 01:36:13.003635 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 9 01:36:13.003652 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 9 01:36:13.003664 systemd[1]: Mounted media.mount - External Media Directory. Sep 9 01:36:13.003675 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 9 01:36:13.003687 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 9 01:36:13.003699 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 9 01:36:13.003712 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 01:36:13.003724 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 9 01:36:13.003736 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 9 01:36:13.003756 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 9 01:36:13.003767 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 9 01:36:13.003779 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 9 01:36:13.003793 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 9 01:36:13.003805 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 9 01:36:13.003816 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 9 01:36:13.003827 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 9 01:36:13.003840 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Sep 9 01:36:13.003853 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 9 01:36:13.003865 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Sep 9 01:36:13.003876 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 9 01:36:13.003888 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 01:36:13.003900 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 01:36:13.003912 kernel: fuse: init (API version 7.41) Sep 9 01:36:13.003923 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 9 01:36:13.003935 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 9 01:36:13.003946 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 9 01:36:13.003972 systemd-journald[2187]: Collecting audit messages is enabled. Sep 9 01:36:13.004006 systemd-journald[2187]: Journal started Sep 9 01:36:13.004033 systemd-journald[2187]: Runtime Journal (/run/log/journal/2a8e74a0ae5d4ddcbffa946e0ff2acca) is 8M, max 158.5M, 150.5M free. Sep 9 01:36:12.218000 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 Sep 9 01:36:12.525000 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' Sep 9 01:36:12.527000 audit: BPF prog-id=18 op=UNLOAD Sep 9 01:36:12.527000 audit: BPF prog-id=17 op=UNLOAD Sep 9 01:36:12.528000 audit: BPF prog-id=19 op=LOAD Sep 9 01:36:12.528000 audit: BPF prog-id=20 op=LOAD Sep 9 01:36:12.528000 audit: BPF prog-id=21 op=LOAD Sep 9 01:36:12.797000 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' Sep 9 01:36:12.800000 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' Sep 9 01:36:12.800000 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' Sep 9 01:36:12.805000 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' Sep 9 01:36:12.834000 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' Sep 9 01:36:12.884000 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' Sep 9 01:36:12.915000 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' Sep 9 01:36:12.915000 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' Sep 9 01:36:12.972000 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' Sep 9 01:36:12.997000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Sep 9 01:36:12.997000 audit[2187]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=3 a1=7ffe06a7e430 a2=4000 a3=0 items=0 ppid=1 pid=2187 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) Sep 9 01:36:12.997000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Sep 9 01:36:11.762360 systemd[1]: Queued start job for default target multi-user.target. Sep 9 01:36:11.775777 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Sep 9 01:36:11.777091 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 9 01:36:12.766598 systemd-modules-load[2191]: Using 2 probe threads Sep 9 01:36:13.007000 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' Sep 9 01:36:13.009839 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 01:36:13.016735 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 9 01:36:13.034671 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 01:36:13.037000 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' Sep 9 01:36:13.078879 systemd-journald[2187]: Time spent on flushing to /var/log/journal/2a8e74a0ae5d4ddcbffa946e0ff2acca is 16.161ms for 1189 entries. Sep 9 01:36:13.078879 systemd-journald[2187]: System Journal (/var/log/journal/2a8e74a0ae5d4ddcbffa946e0ff2acca) is 8M, max 2.2G, 2.2G free. Sep 9 01:36:13.080000 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' Sep 9 01:36:13.405000 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' Sep 9 01:36:13.484000 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' Sep 9 01:36:13.835806 systemd-journald[2187]: Received client request to flush runtime journal. Sep 9 01:36:13.079852 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 01:36:13.084606 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 9 01:36:13.099407 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 9 01:36:13.405637 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 9 01:36:13.408236 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 9 01:36:13.480538 systemd-tmpfiles[2200]: ACLs are not supported, ignoring. Sep 9 01:36:13.480551 systemd-tmpfiles[2200]: ACLs are not supported, ignoring. Sep 9 01:36:13.482985 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 01:36:13.837994 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 9 01:36:13.839000 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' Sep 9 01:36:14.777978 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 9 01:36:14.787000 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' Sep 9 01:36:14.789880 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 9 01:36:15.088664 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 9 01:36:15.090000 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' Sep 9 01:36:15.094391 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Sep 9 01:36:15.097000 audit: BPF prog-id=22 op=LOAD Sep 9 01:36:15.097000 audit: BPF prog-id=23 op=LOAD Sep 9 01:36:15.097000 audit: BPF prog-id=24 op=LOAD Sep 9 01:36:15.099392 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Sep 9 01:36:15.102000 audit: BPF prog-id=25 op=LOAD Sep 9 01:36:15.104421 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 01:36:15.109898 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 01:36:15.112705 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 9 01:36:15.132284 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Sep 9 01:36:15.136000 audit: BPF prog-id=26 op=LOAD Sep 9 01:36:15.136000 audit: BPF prog-id=27 op=LOAD Sep 9 01:36:15.136000 audit: BPF prog-id=28 op=LOAD Sep 9 01:36:15.138858 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 9 01:36:15.147057 systemd-tmpfiles[2257]: ACLs are not supported, ignoring. Sep 9 01:36:15.147287 systemd-tmpfiles[2257]: ACLs are not supported, ignoring. Sep 9 01:36:15.150335 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 01:36:15.150000 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' Sep 9 01:36:15.153250 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 9 01:36:15.156845 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Sep 9 01:36:15.156870 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 01:36:15.158459 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Sep 9 01:36:15.230777 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 9 01:36:15.232995 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 9 01:36:15.234356 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Sep 9 01:36:15.235170 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Sep 9 01:36:15.238180 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 9 01:36:15.239804 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Sep 9 01:36:15.244846 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Sep 9 01:36:15.247598 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 2259 ((systemd-userd)) Sep 9 01:36:15.248301 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Sep 9 01:36:15.429000 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' Sep 9 01:36:15.520000 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' Sep 9 01:36:15.573000 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' Sep 9 01:36:15.573000 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' Sep 9 01:36:15.573000 audit: BPF prog-id=29 op=LOAD Sep 9 01:36:15.574000 audit: BPF prog-id=30 op=LOAD Sep 9 01:36:15.574000 audit: BPF prog-id=31 op=LOAD Sep 9 01:36:15.607000 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' Sep 9 01:36:15.758860 kernel: loop4: detected capacity change from 0 to 44472 Sep 9 01:36:15.427163 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Sep 9 01:36:15.759153 kernel: loop4: p1 p2 p3 Sep 9 01:36:15.458778 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Sep 9 01:36:15.759510 kernel: tun: Universal TUN/TAP device driver, 1.6 Sep 9 01:36:15.519498 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 9 01:36:15.759597 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:15.571081 systemd[1]: modprobe@tun.service: Deactivated successfully. Sep 9 01:36:15.759706 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:36:15.571233 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Sep 9 01:36:15.759816 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:36:15.576250 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Sep 9 01:36:15.759948 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:36:15.605458 systemd-nsresourced[2276]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Sep 9 01:36:15.760515 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:15.606293 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Sep 9 01:36:15.671461 systemd-confext[2267]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Sep 9 01:36:15.772425 systemd-oomd[2255]: No swap; memory pressure usage will be degraded Sep 9 01:36:15.774000 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' Sep 9 01:36:16.205000 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' Sep 9 01:36:15.773232 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Sep 9 01:36:15.825113 systemd-resolved[2256]: Positive Trust Anchors: Sep 9 01:36:15.825119 systemd-resolved[2256]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 01:36:15.825122 systemd-resolved[2256]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 9 01:36:15.825146 systemd-resolved[2256]: 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 Sep 9 01:36:16.205089 systemd-resolved[2256]: Using system hostname 'ci-4790.0.0-n-b349b5973d'. Sep 9 01:36:16.206549 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 01:36:16.207786 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 01:36:16.333557 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 9 01:36:16.335000 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' Sep 9 01:36:16.335000 audit: BPF prog-id=7 op=UNLOAD Sep 9 01:36:16.335000 audit: BPF prog-id=6 op=UNLOAD Sep 9 01:36:16.335000 audit: BPF prog-id=32 op=LOAD Sep 9 01:36:16.335000 audit: BPF prog-id=33 op=LOAD Sep 9 01:36:16.338276 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 01:36:16.970954 systemd-udevd[2290]: Using default interface naming scheme 'v260'. Sep 9 01:36:17.552919 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 01:36:17.554000 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' Sep 9 01:36:17.567648 kernel: kauditd_printk_skb: 62 callbacks suppressed Sep 9 01:36:17.567692 kernel: audit: type=1130 audit(1788917777.554:159): 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' Sep 9 01:36:17.554000 audit: BPF prog-id=34 op=LOAD Sep 9 01:36:17.569795 kernel: audit: type=1334 audit(1788917777.554:160): prog-id=34 op=LOAD Sep 9 01:36:17.569986 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 9 01:36:17.637512 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 9 01:36:17.983822 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#272 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Sep 9 01:36:18.015343 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Sep 9 01:36:18.077770 kernel: mousedev: PS/2 mouse device common for all mice Sep 9 01:36:18.082924 systemd-networkd[2292]: lo: Link UP Sep 9 01:36:18.082933 systemd-networkd[2292]: lo: Gained carrier Sep 9 01:36:18.084429 systemd[1]: Started systemd-networkd.service - Network Management. Sep 9 01:36:18.084719 systemd-networkd[2292]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 9 01:36:18.084723 systemd-networkd[2292]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 01:36:18.088647 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Sep 9 01:36:18.087000 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' Sep 9 01:36:18.090444 kernel: audit: type=1130 audit(1788917778.087:161): 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' Sep 9 01:36:18.088973 systemd[1]: Reached target network.target - Network. Sep 9 01:36:18.096421 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Sep 9 01:36:18.100275 kernel: hv_netvsc f8615163-0000-1000-2000-7c1e52774ee8 eth0: Data path switched to VF: enP30832s1 Sep 9 01:36:18.097292 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 9 01:36:18.100669 systemd-networkd[2292]: enP30832s1: Link UP Sep 9 01:36:18.100772 systemd-networkd[2292]: eth0: Link UP Sep 9 01:36:18.100775 systemd-networkd[2292]: eth0: Gained carrier Sep 9 01:36:18.100789 systemd-networkd[2292]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 9 01:36:18.103274 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Sep 9 01:36:18.107133 systemd-networkd[2292]: enP30832s1: Gained carrier Sep 9 01:36:18.115676 systemd-networkd[2292]: eth0: DHCPv4 address 10.0.0.22/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 9 01:36:18.124797 kernel: hv_vmbus: registering driver hv_balloon Sep 9 01:36:18.125001 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Sep 9 01:36:18.129408 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 01:36:18.138762 kernel: hv_vmbus: registering driver hyperv_fb Sep 9 01:36:18.143790 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Sep 9 01:36:18.146478 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Sep 9 01:36:18.147157 kernel: Console: switching to colour dummy device 80x25 Sep 9 01:36:18.147522 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 01:36:18.147739 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 01:36:18.150000 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' Sep 9 01:36:18.155816 kernel: Console: switching to colour frame buffer device 128x48 Sep 9 01:36:18.155852 kernel: audit: type=1130 audit(1788917778.150:162): 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' Sep 9 01:36:18.150000 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' Sep 9 01:36:18.161225 kernel: audit: type=1131 audit(1788917778.150:163): 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' Sep 9 01:36:18.157913 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 01:36:18.167565 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Sep 9 01:36:18.183937 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 01:36:18.184546 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 01:36:18.186000 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' Sep 9 01:36:18.186000 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' Sep 9 01:36:18.192953 kernel: audit: type=1130 audit(1788917778.186:164): 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' Sep 9 01:36:18.192986 kernel: audit: type=1131 audit(1788917778.186:165): 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' Sep 9 01:36:18.199794 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 01:36:18.216300 kernel: loop4: detected capacity change from 0 to 44472 Sep 9 01:36:18.218943 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 9 01:36:18.220000 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' Sep 9 01:36:18.226442 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 9 01:36:18.229913 kernel: audit: type=1130 audit(1788917778.220:166): 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' Sep 9 01:36:18.232846 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 9 01:36:18.235000 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' Sep 9 01:36:18.247792 kernel: audit: type=1130 audit(1788917778.235:167): 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' Sep 9 01:36:18.247851 kernel: loop4: p1 p2 p3 Sep 9 01:36:18.258086 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.258148 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:36:18.265824 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:36:18.267767 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:36:18.269786 (sd-merge)[2365]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Sep 9 01:36:18.275304 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.327775 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Sep 9 01:36:18.328310 (sd-merge)[2365]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 9 01:36:18.332358 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Sep 9 01:36:18.333000 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' Sep 9 01:36:18.341710 kernel: audit: type=1130 audit(1788917778.333:168): 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' Sep 9 01:36:18.343177 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 9 01:36:18.375634 kernel: kvm_intel: Using Hyper-V Enlightened VMCS Sep 9 01:36:18.386147 kernel: loop4: detected capacity change from 0 to 137288 Sep 9 01:36:18.389873 kernel: cpu_based_exec_ctrl unsupported with eVMCS: 0x20000 Sep 9 01:36:18.401772 kernel: loop4: p1 p2 p3 Sep 9 01:36:18.413873 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.413928 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:36:18.416174 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:36:18.416450 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Sep 9 01:36:18.417465 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:36:18.418822 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 9 01:36:18.419863 systemd-sysext[2386]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Sep 9 01:36:18.426799 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.450224 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 9 01:36:18.470769 kernel: loop4: detected capacity change from 0 to 404728 Sep 9 01:36:18.473143 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 9 01:36:18.471000 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' Sep 9 01:36:18.477866 kernel: loop4: p1 p2 p3 Sep 9 01:36:18.484768 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.484822 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:36:18.484841 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:36:18.488449 systemd-sysext[2386]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Sep 9 01:36:18.488866 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:36:18.490792 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.512806 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 9 01:36:18.531762 kernel: loop4: detected capacity change from 0 to 183704 Sep 9 01:36:18.539769 kernel: loop4: p1 p2 p3 Sep 9 01:36:18.548075 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.548125 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:36:18.550250 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:36:18.551908 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:36:18.551978 systemd-sysext[2386]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Sep 9 01:36:18.554768 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.577804 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 9 01:36:18.604762 kernel: loop4: detected capacity change from 0 to 137288 Sep 9 01:36:18.610047 kernel: loop4: p1 p2 p3 Sep 9 01:36:18.614205 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.614266 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:36:18.614282 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:36:18.615931 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:36:18.616307 (sd-merge)[2414]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Sep 9 01:36:18.618776 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.627339 systemd-vconsole-setup[2364]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 9 01:36:18.628641 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 01:36:18.629000 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' Sep 9 01:36:18.647782 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 9 01:36:18.649774 kernel: loop5: detected capacity change from 0 to 404728 Sep 9 01:36:18.653770 kernel: loop5: p1 p2 p3 Sep 9 01:36:18.657791 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.657878 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:36:18.659536 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:36:18.660911 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:36:18.660916 (sd-merge)[2414]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Sep 9 01:36:18.662719 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.687772 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Sep 9 01:36:18.692770 kernel: loop6: detected capacity change from 0 to 183704 Sep 9 01:36:18.701813 kernel: loop6: p1 p2 p3 Sep 9 01:36:18.705959 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.706004 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 9 01:36:18.707080 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Sep 9 01:36:18.707850 kernel: device-mapper: ioctl: error adding target to table Sep 9 01:36:18.707912 (sd-merge)[2414]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Sep 9 01:36:18.708764 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Sep 9 01:36:18.729775 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Sep 9 01:36:18.731071 (sd-merge)[2414]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 9 01:36:18.734410 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 9 01:36:18.733000 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' Sep 9 01:36:18.744422 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 01:36:18.764571 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/base_image_var.conf:29: Duplicate line for path "/var/log/audit", ignoring. Sep 9 01:36:18.765395 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/base_image_var_late.conf:44: Duplicate line for path "/var/log/audit", ignoring. Sep 9 01:36:18.765606 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/baselayout.conf:15: Duplicate line for path "/var", ignoring. Sep 9 01:36:18.765617 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/baselayout.conf:16: Duplicate line for path "/var/empty", ignoring. Sep 9 01:36:18.765633 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/baselayout.conf:21: Duplicate line for path "/var/log", ignoring. Sep 9 01:36:18.765759 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/dbus.conf:5: Duplicate line for path "/var/lib/dbus", ignoring. Sep 9 01:36:18.765993 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/nfs-utils.conf:2: Duplicate line for path "/var/lib/nfs/v4recovery", ignoring. Sep 9 01:36:18.766833 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 9 01:36:18.766848 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 9 01:36:18.766987 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 9 01:36:18.767692 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/tpm2-tss-fapi.conf:2: Duplicate line for path "/var/lib/tpm2-tss/system/keystore", ignoring. Sep 9 01:36:18.767699 systemd-tmpfiles[2436]: ACLs are not supported, ignoring. Sep 9 01:36:18.767727 systemd-tmpfiles[2436]: ACLs are not supported, ignoring. Sep 9 01:36:18.769089 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/var.conf:10: Duplicate line for path "/var", ignoring. Sep 9 01:36:18.769105 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 9 01:36:18.769170 systemd-tmpfiles[2436]: /usr/lib/tmpfiles.d/var.conf:21: Duplicate line for path "/var/lib", ignoring. Sep 9 01:36:18.771204 systemd-tmpfiles[2436]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 9 01:36:18.771214 systemd-tmpfiles[2436]: Skipping /boot Sep 9 01:36:18.776172 systemd-tmpfiles[2436]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 9 01:36:18.776187 systemd-tmpfiles[2436]: Skipping /boot Sep 9 01:36:18.783143 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 01:36:18.784000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:36:18.787784 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 9 01:36:18.790841 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 9 01:36:18.793939 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 9 01:36:18.799444 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 9 01:36:18.804565 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 9 01:36:18.811000 audit[2442]: AUDIT1127 pid=2442 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' Sep 9 01:36:18.815222 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 9 01:36:18.814000 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' Sep 9 01:36:18.897984 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 9 01:36:18.899000 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' Sep 9 01:36:19.026000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Sep 9 01:36:19.026000 audit[2466]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffd07ade360 a2=420 a3=0 items=0 ppid=2438 pid=2466 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) Sep 9 01:36:19.026000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 9 01:36:19.028237 augenrules[2466]: No rules Sep 9 01:36:19.028420 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 01:36:19.028656 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 9 01:36:19.165982 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 9 01:36:19.169992 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt skipped, unmet condition check ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt Sep 9 01:36:19.969884 systemd-networkd[2292]: eth0: Gained IPv6LL Sep 9 01:36:19.971889 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Sep 9 01:36:19.973444 systemd[1]: Reached target network-online.target - Network is Online. Sep 9 01:36:24.647088 ldconfig[2440]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 9 01:36:24.659330 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 9 01:36:24.663101 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 9 01:36:24.678440 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 9 01:36:24.679982 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 01:36:24.681428 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 9 01:36:24.683839 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 9 01:36:24.686822 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Sep 9 01:36:24.688447 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 9 01:36:24.690885 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 9 01:36:24.692256 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Sep 9 01:36:24.694836 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Sep 9 01:36:24.696065 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 9 01:36:24.697722 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Sep 9 01:36:24.697780 systemd[1]: Reached target paths.target - Path Units. Sep 9 01:36:24.700787 systemd[1]: Reached target timers.target - Timer Units. Sep 9 01:36:24.716907 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 9 01:36:24.719932 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 01:36:24.722355 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 9 01:36:24.727285 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 9 01:36:24.731057 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 9 01:36:24.734286 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Sep 9 01:36:24.736996 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 9 01:36:24.739045 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 01:36:24.741262 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 01:36:24.743805 systemd[1]: Reached target basic.target - Basic System. Sep 9 01:36:24.746843 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Sep 9 01:36:24.746872 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Sep 9 01:36:24.748426 systemd[1]: Starting chronyd.service - NTP client/server... Sep 9 01:36:24.750678 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 01:36:24.753534 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 9 01:36:24.757497 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 9 01:36:24.763171 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 9 01:36:24.769548 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 9 01:36:24.771340 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Sep 9 01:36:24.776614 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Sep 9 01:36:24.778385 systemd[1]: hv_fcopy_uio_daemon.service - Hyper-V FCOPY UIO daemon skipped, unmet condition check ConditionPathExists=/sys/bus/vmbus/devices/eb765408-105f-49b6-b4aa-c123b64d17d4/uio Sep 9 01:36:24.782965 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Sep 9 01:36:24.784243 jq[2486]: true Sep 9 01:36:24.785044 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Sep 9 01:36:24.786181 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 9 01:36:24.790616 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 9 01:36:24.797893 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 9 01:36:24.806373 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 9 01:36:24.813940 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 9 01:36:24.815974 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Sep 9 01:36:24.820898 systemd[1]: Starting update-engine.service - Update Engine... Sep 9 01:36:24.825092 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 9 01:36:24.833947 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 9 01:36:24.837606 KVP[2489]: KVP starting; pid is:2489 Sep 9 01:36:24.842957 chronyd[2482]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Sep 9 01:36:24.843987 google_oslogin_nss_cache[2488]: oslogin_cache_refresh[2488]: Refreshing passwd entry cache Sep 9 01:36:24.844259 oslogin_cache_refresh[2488]: Refreshing passwd entry cache Sep 9 01:36:24.846331 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 9 01:36:24.847018 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 9 01:36:24.852230 extend-filesystems[2487]: Found /dev/nvme0n1p6 Sep 9 01:36:24.856826 kernel: hv_utils: KVP IC version 4.0 Sep 9 01:36:24.856858 KVP[2489]: KVP LIC Version: 3.1 Sep 9 01:36:24.860646 jq[2503]: true Sep 9 01:36:24.861501 oslogin_cache_refresh[2488]: Failure getting users, quitting Sep 9 01:36:24.862021 google_oslogin_nss_cache[2488]: oslogin_cache_refresh[2488]: Failure getting users, quitting Sep 9 01:36:24.862021 google_oslogin_nss_cache[2488]: oslogin_cache_refresh[2488]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 9 01:36:24.862021 google_oslogin_nss_cache[2488]: oslogin_cache_refresh[2488]: Refreshing group entry cache Sep 9 01:36:24.861515 oslogin_cache_refresh[2488]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 9 01:36:24.861549 oslogin_cache_refresh[2488]: Refreshing group entry cache Sep 9 01:36:24.872970 motdgen[2516]: /oem/oem-release: line 2: Azure: command not found Sep 9 01:36:24.872960 chronyd[2482]: Timezone right/UTC failed leap second check, ignoring Sep 9 01:36:24.873098 chronyd[2482]: Loaded seccomp filter (level 2) Sep 9 01:36:24.873439 systemd[1]: Started chronyd.service - NTP client/server. Sep 9 01:36:24.876324 oslogin_cache_refresh[2488]: Failure getting groups, quitting Sep 9 01:36:24.876952 google_oslogin_nss_cache[2488]: oslogin_cache_refresh[2488]: Failure getting groups, quitting Sep 9 01:36:24.876952 google_oslogin_nss_cache[2488]: oslogin_cache_refresh[2488]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 9 01:36:24.876334 oslogin_cache_refresh[2488]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 9 01:36:24.881191 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Sep 9 01:36:24.883035 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Sep 9 01:36:24.888635 extend-filesystems[2487]: Found /dev/nvme0n1p9 Sep 9 01:36:24.893118 extend-filesystems[2487]: Checking size of /dev/nvme0n1p9 Sep 9 01:36:24.897120 jq[2501]: false Sep 9 01:36:24.890448 systemctl[2513]: Created symlink '/etc/systemd/system/multi-user.target.wants/oem-cloudinit.service' → '/usr/lib/systemd/system/oem-cloudinit.service'. Sep 9 01:36:24.891539 systemd[1]: motdgen.service: Deactivated successfully. Sep 9 01:36:24.891780 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 9 01:36:24.895937 systemd[1]: Reload requested from client PID 2513 ('systemctl') (unit enable-oem-cloudinit.service)... Sep 9 01:36:24.895947 systemd[1]: Reloading... Sep 9 01:36:24.913891 update_engine[2500]: I20260909 01:36:24.913822 2500 main.cc:92] Flatcar Update Engine starting Sep 9 01:36:24.924643 extend-filesystems[2487]: Resized partition /dev/nvme0n1p9 Sep 9 01:36:24.950431 extend-filesystems[2561]: resize2fs 1.47.4 (6-Mar-2025) Sep 9 01:36:24.963766 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 6359552 to 6376955 blocks Sep 9 01:36:24.969781 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 6376955 Sep 9 01:36:25.030221 zram_generator::config[2592]: No configuration found. Sep 9 01:36:25.006160 systemd-logind[2497]: New seat seat0. Sep 9 01:36:25.030864 systemd-logind[2497]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Sep 9 01:36:25.051770 extend-filesystems[2561]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Sep 9 01:36:25.051770 extend-filesystems[2561]: old_desc_blocks = 4, new_desc_blocks = 4 Sep 9 01:36:25.051770 extend-filesystems[2561]: The filesystem on /dev/nvme0n1p9 is now 6376955 (4k) blocks long. Sep 9 01:36:25.059250 extend-filesystems[2487]: Resized filesystem in /dev/nvme0n1p9 Sep 9 01:36:25.055646 dbus-daemon[2484]: [system] SELinux support is enabled Sep 9 01:36:25.063068 update_engine[2500]: I20260909 01:36:25.061522 2500 update_check_scheduler.cc:74] Next update check in 4m10s Sep 9 01:36:25.298439 sshd_keygen[2560]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Sep 9 01:36:25.360241 systemd[1]: Reloading finished in 464 ms. Sep 9 01:36:25.380521 systemd[1]: Started systemd-logind.service - User Login Management. Sep 9 01:36:25.382321 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 9 01:36:25.385208 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 9 01:36:25.385474 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 9 01:36:25.387362 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 9 01:36:25.389211 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 9 01:36:25.391012 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Sep 9 01:36:25.391179 systemd[1]: update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition skipped, unmet condition check ConditionPathExists=/etc/.ignition-result.json Sep 9 01:36:25.396420 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 9 01:36:25.399926 systemd[1]: Starting oem-cloudinit.service - Run cloudinit... Sep 9 01:36:25.401567 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Sep 9 01:36:25.401763 systemd[1]: system-cloudinit@usr-share-coreos-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/coreos/cloud-config.yml skipped, unmet condition check ConditionFileNotEmpty=/usr/share/coreos/cloud-config.yml Sep 9 01:36:25.401892 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 9 01:36:25.404687 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline skipped, unmet condition check ConditionKernelCommandLine=cloud-config-url Sep 9 01:36:25.404910 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 9 01:36:25.410826 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Sep 9 01:36:25.413891 bash[2679]: + OEMS=(aws gcp azure cloudsigma vmware digitalocean openstack) Sep 9 01:36:25.418281 bash[2683]: + echo aws gcp azure cloudsigma vmware digitalocean openstack Sep 9 01:36:25.418079 systemd[1]: issuegen.service: Deactivated successfully. Sep 9 01:36:25.418457 bash[2684]: + tr ' ' $'\n' Sep 9 01:36:25.418640 bash[2685]: + grep -q -x -F azure Sep 9 01:36:25.418840 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 9 01:36:25.421166 dbus-daemon[2484]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 9 01:36:25.421266 systemd[1]: Started update-engine.service - Update Engine. Sep 9 01:36:25.430045 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 9 01:36:25.433482 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 9 01:36:25.445974 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 9 01:36:25.451527 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Sep 9 01:36:25.462134 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 9 01:36:25.466015 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 9 01:36:25.470077 systemd[1]: Reached target getty.target - Login Prompts. Sep 9 01:36:25.473682 bash[2702]: ++ '[' azure = aws -o azure = openstack ']' Sep 9 01:36:25.473973 bash[2702]: ++ '[' azure = gcp ']' Sep 9 01:36:25.474010 bash[2702]: ++ echo azure Sep 9 01:36:25.474200 bash[2696]: + /usr/bin/coreos-cloudinit --oem=azure Sep 9 01:36:25.610470 bash[2696]: 2026/09/09 01:36:25 Checking availability of "waagent" Sep 9 01:36:25.710838 bash[2696]: 2026/09/09 01:36:25 Checking availability of "waagent" Sep 9 01:36:25.714719 locksmithd[2690]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 9 01:36:25.911049 bash[2696]: 2026/09/09 01:36:25 Checking availability of "waagent" Sep 9 01:36:26.312455 bash[2696]: 2026/09/09 01:36:26 Checking availability of "waagent" Sep 9 01:36:27.032942 containerd[2514]: time="2026-09-09T01:36:27Z" 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 Sep 9 01:36:27.035117 containerd[2514]: time="2026-09-09T01:36:27.035081197Z" level=info msg="starting containerd" revision=e53c7c1516c3b2bff98eb76f1f4117477e6f4e66 version=v2.2.5 Sep 9 01:36:27.046175 containerd[2514]: time="2026-09-09T01:36:27.046140291Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="7.517µs" Sep 9 01:36:27.046175 containerd[2514]: time="2026-09-09T01:36:27.046167233Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 9 01:36:27.046292 containerd[2514]: time="2026-09-09T01:36:27.046202565Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 9 01:36:27.046292 containerd[2514]: time="2026-09-09T01:36:27.046213392Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 9 01:36:27.046345 containerd[2514]: time="2026-09-09T01:36:27.046328618Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 9 01:36:27.046345 containerd[2514]: time="2026-09-09T01:36:27.046340976Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Sep 9 01:36:27.046383 containerd[2514]: time="2026-09-09T01:36:27.046351914Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 01:36:27.046404 containerd[2514]: time="2026-09-09T01:36:27.046396054Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 01:36:27.046427 containerd[2514]: time="2026-09-09T01:36:27.046406651Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 9 01:36:27.046597 containerd[2514]: time="2026-09-09T01:36:27.046576220Z" 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 Sep 9 01:36:27.046597 containerd[2514]: time="2026-09-09T01:36:27.046592953Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 01:36:27.046653 containerd[2514]: time="2026-09-09T01:36:27.046602827Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 01:36:27.046653 containerd[2514]: time="2026-09-09T01:36:27.046610757Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Sep 9 01:36:27.046805 containerd[2514]: time="2026-09-09T01:36:27.046789476Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 9 01:36:27.046867 containerd[2514]: time="2026-09-09T01:36:27.046853649Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 9 01:36:27.047009 containerd[2514]: time="2026-09-09T01:36:27.046995115Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 9 01:36:27.047035 containerd[2514]: time="2026-09-09T01:36:27.047019385Z" 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 Sep 9 01:36:27.047035 containerd[2514]: time="2026-09-09T01:36:27.047029464Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 9 01:36:27.047208 containerd[2514]: time="2026-09-09T01:36:27.047196905Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 9 01:36:27.047800 containerd[2514]: time="2026-09-09T01:36:27.047767169Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 9 01:36:27.047880 containerd[2514]: time="2026-09-09T01:36:27.047851284Z" level=info msg="metadata content store policy set" policy=shared Sep 9 01:36:27.064424 containerd[2514]: time="2026-09-09T01:36:27.064392532Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 9 01:36:27.064492 containerd[2514]: time="2026-09-09T01:36:27.064435142Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 9 01:36:27.064492 containerd[2514]: time="2026-09-09T01:36:27.064468452Z" level=info msg="built-in NRI default validator is disabled" Sep 9 01:36:27.064492 containerd[2514]: time="2026-09-09T01:36:27.064476115Z" level=info msg="runtime interface created" Sep 9 01:36:27.064492 containerd[2514]: time="2026-09-09T01:36:27.064480559Z" level=info msg="created NRI interface" Sep 9 01:36:27.064571 containerd[2514]: time="2026-09-09T01:36:27.064494051Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Sep 9 01:36:27.112891 bash[2696]: 2026/09/09 01:36:27 Checking availability of "waagent" Sep 9 01:36:27.142396 containerd[2514]: time="2026-09-09T01:36:27.142360266Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Sep 9 01:36:27.142554 containerd[2514]: time="2026-09-09T01:36:27.142524924Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 9 01:36:27.142554 containerd[2514]: time="2026-09-09T01:36:27.142550049Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 9 01:36:27.142602 containerd[2514]: time="2026-09-09T01:36:27.142563711Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 9 01:36:27.142602 containerd[2514]: time="2026-09-09T01:36:27.142579132Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 9 01:36:27.142602 containerd[2514]: time="2026-09-09T01:36:27.142589864Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 9 01:36:27.142669 containerd[2514]: time="2026-09-09T01:36:27.142607788Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 9 01:36:27.142669 containerd[2514]: time="2026-09-09T01:36:27.142625573Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 9 01:36:27.142669 containerd[2514]: time="2026-09-09T01:36:27.142638567Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 9 01:36:27.142669 containerd[2514]: time="2026-09-09T01:36:27.142649351Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 9 01:36:27.142669 containerd[2514]: time="2026-09-09T01:36:27.142658447Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 9 01:36:27.142801 containerd[2514]: time="2026-09-09T01:36:27.142669758Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 9 01:36:27.142801 containerd[2514]: time="2026-09-09T01:36:27.142787014Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 9 01:36:27.142855 containerd[2514]: time="2026-09-09T01:36:27.142807233Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 9 01:36:27.142855 containerd[2514]: time="2026-09-09T01:36:27.142818922Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 9 01:36:27.142855 containerd[2514]: time="2026-09-09T01:36:27.142831209Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 9 01:36:27.142855 containerd[2514]: time="2026-09-09T01:36:27.142844028Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 9 01:36:27.142941 containerd[2514]: time="2026-09-09T01:36:27.142854490Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 9 01:36:27.142941 containerd[2514]: time="2026-09-09T01:36:27.142866121Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 9 01:36:27.142941 containerd[2514]: time="2026-09-09T01:36:27.142876738Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 9 01:36:27.142941 containerd[2514]: time="2026-09-09T01:36:27.142888350Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Sep 9 01:36:27.142941 containerd[2514]: time="2026-09-09T01:36:27.142897436Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 9 01:36:27.142941 containerd[2514]: time="2026-09-09T01:36:27.142910228Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 9 01:36:27.142941 containerd[2514]: time="2026-09-09T01:36:27.142920234Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 9 01:36:27.143092 containerd[2514]: time="2026-09-09T01:36:27.142943991Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 9 01:36:27.143092 containerd[2514]: time="2026-09-09T01:36:27.142992627Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 9 01:36:27.143092 containerd[2514]: time="2026-09-09T01:36:27.143006805Z" level=info msg="Start snapshots syncer" Sep 9 01:36:27.143092 containerd[2514]: time="2026-09-09T01:36:27.143024797Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 9 01:36:27.143673 containerd[2514]: time="2026-09-09T01:36:27.143533080Z" 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\"}" Sep 9 01:36:27.143673 containerd[2514]: time="2026-09-09T01:36:27.143608116Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 9 01:36:27.144059 containerd[2514]: time="2026-09-09T01:36:27.144011998Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 9 01:36:27.144169 containerd[2514]: time="2026-09-09T01:36:27.144155624Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 9 01:36:27.144193 containerd[2514]: time="2026-09-09T01:36:27.144181542Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 9 01:36:27.144218 containerd[2514]: time="2026-09-09T01:36:27.144196220Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 9 01:36:27.144218 containerd[2514]: time="2026-09-09T01:36:27.144208745Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 9 01:36:27.144271 containerd[2514]: time="2026-09-09T01:36:27.144221773Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 9 01:36:27.144271 containerd[2514]: time="2026-09-09T01:36:27.144233744Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 9 01:36:27.144271 containerd[2514]: time="2026-09-09T01:36:27.144245027Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 9 01:36:27.144271 containerd[2514]: time="2026-09-09T01:36:27.144257968Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 9 01:36:27.144271 containerd[2514]: time="2026-09-09T01:36:27.144268277Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 9 01:36:27.144379 containerd[2514]: time="2026-09-09T01:36:27.144296634Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 9 01:36:27.144379 containerd[2514]: time="2026-09-09T01:36:27.144310643Z" 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 Sep 9 01:36:27.144379 containerd[2514]: time="2026-09-09T01:36:27.144320258Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 01:36:27.144379 containerd[2514]: time="2026-09-09T01:36:27.144328708Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 01:36:27.144379 containerd[2514]: time="2026-09-09T01:36:27.144336302Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 9 01:36:27.144379 containerd[2514]: time="2026-09-09T01:36:27.144345310Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 9 01:36:27.144379 containerd[2514]: time="2026-09-09T01:36:27.144356749Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 9 01:36:27.144379 containerd[2514]: time="2026-09-09T01:36:27.144368519Z" level=info msg="Connect containerd service" Sep 9 01:36:27.144549 containerd[2514]: time="2026-09-09T01:36:27.144397112Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 01:36:27.145613 containerd[2514]: time="2026-09-09T01:36:27.145577794Z" 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" Sep 9 01:36:27.810841 containerd[2514]: time="2026-09-09T01:36:27.810725165Z" level=info msg="Start subscribing containerd event" Sep 9 01:36:27.810841 containerd[2514]: time="2026-09-09T01:36:27.810814349Z" level=info msg="Start recovering state" Sep 9 01:36:27.811084 containerd[2514]: time="2026-09-09T01:36:27.811069416Z" level=info msg="Start event monitor" Sep 9 01:36:27.811130 containerd[2514]: time="2026-09-09T01:36:27.811086170Z" level=info msg="Start cni network conf syncer for default" Sep 9 01:36:27.811130 containerd[2514]: time="2026-09-09T01:36:27.811093667Z" level=info msg="Start streaming server" Sep 9 01:36:27.811130 containerd[2514]: time="2026-09-09T01:36:27.811106772Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 9 01:36:27.811130 containerd[2514]: time="2026-09-09T01:36:27.811113903Z" level=info msg="runtime interface starting up..." Sep 9 01:36:27.811130 containerd[2514]: time="2026-09-09T01:36:27.811119554Z" level=info msg="starting plugins..." Sep 9 01:36:27.811220 containerd[2514]: time="2026-09-09T01:36:27.811133890Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 9 01:36:27.819325 containerd[2514]: time="2026-09-09T01:36:27.819276690Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 01:36:27.819433 containerd[2514]: time="2026-09-09T01:36:27.819365590Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 01:36:27.821894 containerd[2514]: time="2026-09-09T01:36:27.819497343Z" level=info msg="containerd successfully booted in 0.786771s" Sep 9 01:36:27.819693 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 01:36:28.713052 bash[2696]: 2026/09/09 01:36:28 Checking availability of "waagent" Sep 9 01:36:28.716901 waagent[2697]: 2026-09-09T01:36:28.716829Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Sep 9 01:36:28.718533 waagent[2697]: 2026-09-09T01:36:28.718473Z INFO Daemon Daemon OS: flatcar 4790.0.0 Sep 9 01:36:28.721818 waagent[2697]: 2026-09-09T01:36:28.721785Z INFO Daemon Daemon Python: 3.12.13 Sep 9 01:36:28.725766 waagent[2697]: 2026-09-09T01:36:28.723944Z INFO Daemon Daemon Run daemon Sep 9 01:36:28.725766 waagent[2697]: 2026-09-09T01:36:28.725110Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4790.0.0' Sep 9 01:36:28.729886 waagent[2697]: 2026-09-09T01:36:28.729841Z INFO Daemon Daemon Using waagent for provisioning Sep 9 01:36:28.733008 waagent[2697]: 2026-09-09T01:36:28.732967Z INFO Daemon Daemon Activate resource disk Sep 9 01:36:28.735849 waagent[2697]: 2026-09-09T01:36:28.735815Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Sep 9 01:36:28.738917 waagent[2697]: 2026-09-09T01:36:28.738876Z INFO Daemon Daemon Found device: None Sep 9 01:36:28.741839 waagent[2697]: 2026-09-09T01:36:28.741802Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Sep 9 01:36:28.744831 waagent[2697]: 2026-09-09T01:36:28.744794Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Sep 9 01:36:28.749179 waagent[2697]: 2026-09-09T01:36:28.749128Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 9 01:36:28.750567 waagent[2697]: 2026-09-09T01:36:28.750537Z INFO Daemon Daemon Running default provisioning handler Sep 9 01:36:28.756974 waagent[2697]: 2026-09-09T01:36:28.756595Z 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. Sep 9 01:36:28.769118 waagent[2697]: 2026-09-09T01:36:28.769084Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Sep 9 01:36:28.772843 waagent[2697]: 2026-09-09T01:36:28.772811Z INFO Daemon Daemon cloud-init is enabled: False Sep 9 01:36:28.774845 waagent[2697]: 2026-09-09T01:36:28.774813Z INFO Daemon Daemon Copying ovf-env.xml Sep 9 01:36:28.785953 waagent[2697]: 2026-09-09T01:36:28.785908Z INFO Daemon Daemon Successfully mounted dvd Sep 9 01:36:28.872980 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Sep 9 01:36:28.874972 waagent[2697]: 2026-09-09T01:36:28.873190Z INFO Daemon Daemon Detect protocol endpoint Sep 9 01:36:28.874972 waagent[2697]: 2026-09-09T01:36:28.874846Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 9 01:36:28.876920 waagent[2697]: 2026-09-09T01:36:28.876338Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Sep 9 01:36:28.878852 waagent[2697]: 2026-09-09T01:36:28.878812Z INFO Daemon Daemon Test for route to 168.63.129.16 Sep 9 01:36:28.880935 waagent[2697]: 2026-09-09T01:36:28.880899Z INFO Daemon Daemon Route to 168.63.129.16 exists Sep 9 01:36:28.881969 waagent[2697]: 2026-09-09T01:36:28.881917Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Sep 9 01:36:28.907389 waagent[2697]: 2026-09-09T01:36:28.907357Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Sep 9 01:36:28.909029 waagent[2697]: 2026-09-09T01:36:28.909008Z INFO Daemon Daemon Wire protocol version:2012-11-30 Sep 9 01:36:28.910182 waagent[2697]: 2026-09-09T01:36:28.910142Z INFO Daemon Daemon Server preferred version:2015-04-05 Sep 9 01:36:29.010315 waagent[2697]: 2026-09-09T01:36:29.010195Z INFO Daemon Daemon Initializing goal state during protocol detection Sep 9 01:36:29.013894 waagent[2697]: 2026-09-09T01:36:29.013841Z INFO Daemon Daemon Forcing an update of the goal state. Sep 9 01:36:29.021326 waagent[2697]: 2026-09-09T01:36:29.021286Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 9 01:36:29.040821 waagent[2697]: 2026-09-09T01:36:29.040791Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.185 Sep 9 01:36:29.044151 waagent[2697]: 2026-09-09T01:36:29.044111Z INFO Daemon Sep 9 01:36:29.044871 waagent[2697]: 2026-09-09T01:36:29.044828Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 3f1c9aa8-1349-4561-bfb2-43d7d18727e9 eTag: 6354425611278628258 source: Fabric] Sep 9 01:36:29.047361 waagent[2697]: 2026-09-09T01:36:29.047331Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Sep 9 01:36:29.050000 waagent[2697]: 2026-09-09T01:36:29.049964Z INFO Daemon Sep 9 01:36:29.050780 waagent[2697]: 2026-09-09T01:36:29.050730Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Sep 9 01:36:29.063141 waagent[2697]: 2026-09-09T01:36:29.063114Z INFO Daemon Daemon Downloading artifacts profile blob Sep 9 01:36:29.141273 waagent[2697]: 2026-09-09T01:36:29.141223Z INFO Daemon Downloaded certificate {'thumbprint': 'AA17817C430CD5AD83F4ADD2E768B15B75D9D87F', 'hasPrivateKey': True} Sep 9 01:36:29.146093 waagent[2697]: 2026-09-09T01:36:29.146054Z INFO Daemon Fetch goal state completed Sep 9 01:36:29.152833 waagent[2697]: 2026-09-09T01:36:29.152807Z INFO Daemon Daemon Starting provisioning Sep 9 01:36:29.155820 waagent[2697]: 2026-09-09T01:36:29.155784Z INFO Daemon Daemon Handle ovf-env.xml. Sep 9 01:36:29.156989 waagent[2697]: 2026-09-09T01:36:29.156962Z INFO Daemon Daemon Set hostname [ci-4790.0.0-n-b349b5973d] Sep 9 01:36:29.173677 waagent[2697]: 2026-09-09T01:36:29.173637Z INFO Daemon Daemon Publish hostname [ci-4790.0.0-n-b349b5973d] Sep 9 01:36:29.175062 waagent[2697]: 2026-09-09T01:36:29.175028Z INFO Daemon Daemon Examine /proc/net/route for primary interface Sep 9 01:36:29.177964 waagent[2697]: 2026-09-09T01:36:29.177922Z INFO Daemon Daemon Primary interface is [eth0] Sep 9 01:36:29.186066 systemd-networkd[2292]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 9 01:36:29.186076 systemd-networkd[2292]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Sep 9 01:36:29.186102 systemd-networkd[2292]: eth0: DHCP lease lost Sep 9 01:36:29.201880 waagent[2697]: 2026-09-09T01:36:29.201838Z INFO Daemon Daemon Create user account if not exists Sep 9 01:36:29.203156 waagent[2697]: 2026-09-09T01:36:29.203120Z INFO Daemon Daemon User core already exists, skip useradd Sep 9 01:36:29.206846 waagent[2697]: 2026-09-09T01:36:29.206812Z INFO Daemon Daemon Configure sudoer Sep 9 01:36:29.208059 waagent[2697]: 2026-09-09T01:36:29.208019Z INFO Daemon Daemon Configure sshd Sep 9 01:36:29.210983 waagent[2697]: 2026-09-09T01:36:29.210947Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Sep 9 01:36:29.214846 waagent[2697]: 2026-09-09T01:36:29.214813Z INFO Daemon Daemon Deploy ssh public key. Sep 9 01:36:29.224792 systemd-networkd[2292]: eth0: DHCPv4 address 10.0.0.22/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 9 01:36:30.316467 waagent[2697]: 2026-09-09T01:36:30.316401Z INFO Daemon Daemon Provisioning complete Sep 9 01:36:30.328816 waagent[2697]: 2026-09-09T01:36:30.328772Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Sep 9 01:36:30.331896 waagent[2697]: 2026-09-09T01:36:30.331853Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Sep 9 01:36:30.333998 waagent[2697]: 2026-09-09T01:36:30.333962Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Sep 9 01:36:30.443301 waagent[2762]: 2026-09-09T01:36:30.443225Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Sep 9 01:36:30.443683 waagent[2762]: 2026-09-09T01:36:30.443342Z INFO ExtHandler ExtHandler OS: flatcar 4790.0.0 Sep 9 01:36:30.443683 waagent[2762]: 2026-09-09T01:36:30.443391Z INFO ExtHandler ExtHandler Python: 3.12.13 Sep 9 01:36:30.443683 waagent[2762]: 2026-09-09T01:36:30.443429Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Sep 9 01:36:30.478883 waagent[2762]: 2026-09-09T01:36:30.478830Z INFO ExtHandler ExtHandler Distro: flatcar-4790.0.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.13; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Sep 9 01:36:30.479034 waagent[2762]: 2026-09-09T01:36:30.479009Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 9 01:36:30.479106 waagent[2762]: 2026-09-09T01:36:30.479086Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 9 01:36:30.486629 waagent[2762]: 2026-09-09T01:36:30.486576Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 9 01:36:30.492954 waagent[2762]: 2026-09-09T01:36:30.492925Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.185 Sep 9 01:36:30.493293 waagent[2762]: 2026-09-09T01:36:30.493265Z INFO ExtHandler Sep 9 01:36:30.493352 waagent[2762]: 2026-09-09T01:36:30.493328Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: dae9a640-737f-4cc5-b76e-2e2908f4a287 eTag: 6354425611278628258 source: Fabric] Sep 9 01:36:30.493550 waagent[2762]: 2026-09-09T01:36:30.493528Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Sep 9 01:36:30.493928 waagent[2762]: 2026-09-09T01:36:30.493897Z INFO ExtHandler Sep 9 01:36:30.493967 waagent[2762]: 2026-09-09T01:36:30.493953Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Sep 9 01:36:30.500304 waagent[2762]: 2026-09-09T01:36:30.500275Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Sep 9 01:36:30.579237 waagent[2762]: 2026-09-09T01:36:30.579156Z INFO ExtHandler Downloaded certificate {'thumbprint': 'AA17817C430CD5AD83F4ADD2E768B15B75D9D87F', 'hasPrivateKey': True} Sep 9 01:36:30.579562 waagent[2762]: 2026-09-09T01:36:30.579530Z INFO ExtHandler Fetch goal state completed Sep 9 01:36:30.588884 waagent[2762]: 2026-09-09T01:36:30.588839Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.7 9 Jun 2026 (Library: OpenSSL 3.5.7 9 Jun 2026) Sep 9 01:36:30.592040 waagent[2762]: 2026-09-09T01:36:30.591998Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2762 Sep 9 01:36:30.592164 waagent[2762]: 2026-09-09T01:36:30.592141Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Sep 9 01:36:30.592399 waagent[2762]: 2026-09-09T01:36:30.592376Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Sep 9 01:36:30.593476 waagent[2762]: 2026-09-09T01:36:30.593440Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4790.0.0', '', 'Flatcar Container Linux by Kinvolk'] Sep 9 01:36:30.593824 waagent[2762]: 2026-09-09T01:36:30.593784Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4790.0.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Sep 9 01:36:30.593922 waagent[2762]: 2026-09-09T01:36:30.593903Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Sep 9 01:36:30.594339 waagent[2762]: 2026-09-09T01:36:30.594317Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Sep 9 01:36:30.641185 waagent[2762]: 2026-09-09T01:36:30.641159Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Sep 9 01:36:30.641312 waagent[2762]: 2026-09-09T01:36:30.641291Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Sep 9 01:36:30.646177 waagent[2762]: 2026-09-09T01:36:30.645803Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Sep 9 01:36:30.650168 systemd[1]: Reload requested from client PID 2777 ('systemctl') (unit waagent.service)... Sep 9 01:36:30.650184 systemd[1]: Reloading... Sep 9 01:36:30.717822 zram_generator::config[2821]: No configuration found. Sep 9 01:36:30.931767 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#271 cmd 0x4a status: scsi 0x0 srb 0x20 hv 0xc0000001 Sep 9 01:36:30.950991 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#276 cmd 0xa1 status: scsi 0x0 srb 0x20 hv 0xc0000001 Sep 9 01:36:30.961767 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#278 cmd 0x4a status: scsi 0x0 srb 0x20 hv 0xc0000001 Sep 9 01:36:30.970765 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#281 cmd 0x4a status: scsi 0x0 srb 0x20 hv 0xc0000001 Sep 9 01:36:30.974318 systemd[1]: Reloading finished in 323 ms. Sep 9 01:36:30.990917 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#286 cmd 0x4a status: scsi 0x0 srb 0x20 hv 0xc0000001 Sep 9 01:36:31.003770 waagent[2762]: 2026-09-09T01:36:31.003637Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Sep 9 01:36:31.003934 waagent[2762]: 2026-09-09T01:36:31.003905Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Sep 9 01:36:31.019876 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#24 cmd 0x4a status: scsi 0x0 srb 0x20 hv 0xc0000001 Sep 9 01:36:31.030864 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#26 cmd 0x4a status: scsi 0x0 srb 0x20 hv 0xc0000001 Sep 9 01:36:31.122522 login[2700]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Sep 9 01:36:31.128460 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 9 01:36:31.130065 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 9 01:36:31.135256 systemd-logind[2497]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Sep 9 01:36:31.159469 login[2701]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Sep 9 01:36:31.170996 systemd-logind[2497]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Sep 9 01:36:31.201038 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 9 01:36:31.207100 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 9 01:36:31.208051 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 9 01:36:31.554424 waagent[2762]: 2026-09-09T01:36:31.554304Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Sep 9 01:36:31.554782 waagent[2762]: 2026-09-09T01:36:31.554634Z 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] Sep 9 01:36:31.555329 waagent[2762]: 2026-09-09T01:36:31.555271Z INFO ExtHandler ExtHandler Starting env monitor service. Sep 9 01:36:31.555760 waagent[2762]: 2026-09-09T01:36:31.555638Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Sep 9 01:36:31.555912 waagent[2762]: 2026-09-09T01:36:31.555887Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 9 01:36:31.555993 waagent[2762]: 2026-09-09T01:36:31.555971Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 9 01:36:31.556155 waagent[2762]: 2026-09-09T01:36:31.556123Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 9 01:36:31.556324 waagent[2762]: 2026-09-09T01:36:31.556296Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Sep 9 01:36:31.556415 waagent[2762]: 2026-09-09T01:36:31.556391Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 9 01:36:31.556589 waagent[2762]: 2026-09-09T01:36:31.556565Z INFO EnvHandler ExtHandler Configure routes Sep 9 01:36:31.556692 waagent[2762]: 2026-09-09T01:36:31.556620Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Sep 9 01:36:31.556718 waagent[2762]: 2026-09-09T01:36:31.556695Z INFO EnvHandler ExtHandler Gateway:None Sep 9 01:36:31.556801 waagent[2762]: 2026-09-09T01:36:31.556738Z INFO EnvHandler ExtHandler Routes:None Sep 9 01:36:31.557456 waagent[2762]: 2026-09-09T01:36:31.557430Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Sep 9 01:36:31.557597 waagent[2762]: 2026-09-09T01:36:31.557569Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Sep 9 01:36:31.557813 waagent[2762]: 2026-09-09T01:36:31.557791Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Sep 9 01:36:31.557935 waagent[2762]: 2026-09-09T01:36:31.557914Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Sep 9 01:36:31.558647 waagent[2762]: 2026-09-09T01:36:31.558622Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Sep 9 01:36:31.558647 waagent[2762]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Sep 9 01:36:31.558647 waagent[2762]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Sep 9 01:36:31.558647 waagent[2762]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Sep 9 01:36:31.558647 waagent[2762]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Sep 9 01:36:31.558647 waagent[2762]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 9 01:36:31.558647 waagent[2762]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 9 01:36:31.571330 waagent[2762]: 2026-09-09T01:36:31.571304Z INFO ExtHandler ExtHandler Sep 9 01:36:31.571431 waagent[2762]: 2026-09-09T01:36:31.571419Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 42b8dbad-bacb-45ca-a8c7-53709c670d6e correlation 6f510beb-c15f-4eb6-af30-88deb973165b created: 2026-09-09T01:35:21.874039Z] Sep 9 01:36:31.571667 waagent[2762]: 2026-09-09T01:36:31.571653Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Sep 9 01:36:31.572082 waagent[2762]: 2026-09-09T01:36:31.572064Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Sep 9 01:36:31.605993 waagent[2762]: 2026-09-09T01:36:31.605949Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 37451D02-87C6-4E5F-9D92-A3AFE2493781;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Sep 9 01:36:31.608053 waagent[2762]: 2026-09-09T01:36:31.608007Z INFO MonitorHandler ExtHandler Network interfaces: Sep 9 01:36:31.608053 waagent[2762]: Executing ['ip', '-a', '-o', 'link']: Sep 9 01:36:31.608053 waagent[2762]: 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 Sep 9 01:36:31.608053 waagent[2762]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:1e:52:77:4e:e8 brd ff:ff:ff:ff:ff:ff\ alias Network Device\ altname enx7c1e52774ee8 Sep 9 01:36:31.608053 waagent[2762]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 7c:1e:52:77:4e:e8 brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0\ altname enp0s0\ altname ens1 Sep 9 01:36:31.608053 waagent[2762]: Executing ['ip', '-4', '-a', '-o', 'address']: Sep 9 01:36:31.608053 waagent[2762]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Sep 9 01:36:31.608053 waagent[2762]: 2: eth0 inet 10.0.0.22/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Sep 9 01:36:31.608053 waagent[2762]: Executing ['ip', '-6', '-a', '-o', 'address']: Sep 9 01:36:31.608053 waagent[2762]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Sep 9 01:36:31.608053 waagent[2762]: 2: eth0 inet6 fe80::7e1e:52ff:fe77:4ee8/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Sep 9 01:36:31.658514 waagent[2762]: 2026-09-09T01:36:31.658465Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Sep 9 01:36:31.658514 waagent[2762]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 9 01:36:31.658514 waagent[2762]: pkts bytes target prot opt in out source destination Sep 9 01:36:31.658514 waagent[2762]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 9 01:36:31.658514 waagent[2762]: pkts bytes target prot opt in out source destination Sep 9 01:36:31.658514 waagent[2762]: Chain OUTPUT (policy ACCEPT 4 packets, 595 bytes) Sep 9 01:36:31.658514 waagent[2762]: pkts bytes target prot opt in out source destination Sep 9 01:36:31.658514 waagent[2762]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 9 01:36:31.658514 waagent[2762]: 1 52 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 9 01:36:31.658514 waagent[2762]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 9 01:36:31.661234 waagent[2762]: 2026-09-09T01:36:31.661187Z INFO EnvHandler ExtHandler Current Firewall rules: Sep 9 01:36:31.661234 waagent[2762]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 9 01:36:31.661234 waagent[2762]: pkts bytes target prot opt in out source destination Sep 9 01:36:31.661234 waagent[2762]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 9 01:36:31.661234 waagent[2762]: pkts bytes target prot opt in out source destination Sep 9 01:36:31.661234 waagent[2762]: Chain OUTPUT (policy ACCEPT 6 packets, 884 bytes) Sep 9 01:36:31.661234 waagent[2762]: pkts bytes target prot opt in out source destination Sep 9 01:36:31.661234 waagent[2762]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 9 01:36:31.661234 waagent[2762]: 1 52 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 9 01:36:31.661234 waagent[2762]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 9 01:36:31.915429 bash[2696]: 2026/09/09 01:36:31 Checking availability of "waagent" Sep 9 01:36:31.915429 bash[2696]: 2026/09/09 01:36:31 Fetching meta-data from datasource of type "waagent" Sep 9 01:36:31.915429 bash[2696]: 2026/09/09 01:36:31 Attempting to read from "/var/lib/waagent/SharedConfig.xml" Sep 9 01:36:31.916047 bash[2696]: 2026/09/09 01:36:31 Fetching user-data from datasource of type "waagent" Sep 9 01:36:31.916047 bash[2696]: 2026/09/09 01:36:31 Attempting to read from "/var/lib/waagent/CustomData" Sep 9 01:36:31.916365 systemd[1]: oem-cloudinit.service: Deactivated successfully. Sep 9 01:36:31.916658 systemd[1]: Finished oem-cloudinit.service - Run cloudinit. Sep 9 01:36:31.919867 systemd[1]: Finished enable-oem-cloudinit.service - Enable cloudinit. Sep 9 01:36:31.921439 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 9 01:36:31.923502 systemd[1]: Startup finished in 4.160s (kernel) + 12.331s (initrd) + 31.289s (userspace) = 47.781s. Sep 9 01:36:38.025340 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 9 01:36:38.026474 systemd[1]: Started sshd@0-1-10.0.0.22:22-20.101.212.173:49718.service - OpenSSH per-connection server daemon (20.101.212.173:49718). Sep 9 01:36:38.295607 sshd[2965]: Accepted publickey for core from 20.101.212.173 port 49718 ssh2: RSA SHA256:DHl1hUxJU9E/jYlbwneRthndozW7c9qspn9/duOHSAk Sep 9 01:36:38.296261 sshd-session[2965]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 01:36:38.306709 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 9 01:36:38.309974 systemd-logind[2497]: New session '3' of user 'core' with class 'user' and type 'tty'. Sep 9 01:36:38.315676 (systemd)[2969]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Sep 9 01:36:38.317562 systemd-logind[2497]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Sep 9 01:36:38.500691 systemd[2969]: Queued start job for default target default.target. Sep 9 01:36:38.510392 systemd[2969]: Created slice app.slice - User Application Slice. Sep 9 01:36:38.510422 systemd[2969]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Sep 9 01:36:38.510438 systemd[2969]: Reached target machines.target - Virtual Machines and Containers. Sep 9 01:36:38.510479 systemd[2969]: Reached target paths.target - Paths. Sep 9 01:36:38.510503 systemd[2969]: Reached target timers.target - Timers. Sep 9 01:36:38.511434 systemd[2969]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 9 01:36:38.512940 systemd[2969]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 9 01:36:38.513083 systemd[2969]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 9 01:36:38.514058 systemd[2969]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 9 01:36:38.514287 systemd[2969]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 9 01:36:38.514963 systemd[2969]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Sep 9 01:36:38.524018 systemd[2969]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 9 01:36:38.524082 systemd[2969]: Reached target sockets.target - Sockets. Sep 9 01:36:38.525680 systemd[2969]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Sep 9 01:36:38.525796 systemd[2969]: Reached target basic.target - Basic System. Sep 9 01:36:38.525842 systemd[2969]: Reached target default.target - Main User Target. Sep 9 01:36:38.525866 systemd[2969]: Startup finished in 204ms. Sep 9 01:36:38.526228 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 9 01:36:38.536918 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 9 01:36:38.596528 systemd[1]: Started sshd@1-2-10.0.0.22:22-20.101.212.173:47550.service - OpenSSH per-connection server daemon (20.101.212.173:47550). Sep 9 01:36:38.705991 sshd[2983]: Accepted publickey for core from 20.101.212.173 port 47550 ssh2: RSA SHA256:DHl1hUxJU9E/jYlbwneRthndozW7c9qspn9/duOHSAk Sep 9 01:36:38.707019 sshd-session[2983]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 01:36:38.711329 systemd-logind[2497]: New session '5' of user 'core' with class 'user' and type 'tty'. Sep 9 01:36:38.714889 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 9 01:36:38.751607 sshd[2987]: Connection closed by 20.101.212.173 port 47550 Sep 9 01:36:38.752802 sshd-session[2983]: pam_unix(sshd:session): session closed for user core Sep 9 01:36:38.754377 systemd[1]: sshd@1-2-10.0.0.22:22-20.101.212.173:47550.service: Deactivated successfully. Sep 9 01:36:38.755823 systemd[1]: session-5.scope: Deactivated successfully. Sep 9 01:36:38.757458 systemd-logind[2497]: Session 5 logged out. Waiting for processes to exit. Sep 9 01:36:38.758320 systemd-logind[2497]: Removed session 5. Sep 9 01:36:38.779078 systemd[1]: Started sshd@2-3-10.0.0.22:22-20.101.212.173:47564.service - OpenSSH per-connection server daemon (20.101.212.173:47564). Sep 9 01:36:38.889646 sshd[2993]: Accepted publickey for core from 20.101.212.173 port 47564 ssh2: RSA SHA256:DHl1hUxJU9E/jYlbwneRthndozW7c9qspn9/duOHSAk Sep 9 01:36:38.890122 sshd-session[2993]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 01:36:38.894410 systemd-logind[2497]: New session '6' of user 'core' with class 'user' and type 'tty'. Sep 9 01:36:38.898910 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 9 01:36:38.932981 sshd[2997]: Connection closed by 20.101.212.173 port 47564 Sep 9 01:36:38.933879 sshd-session[2993]: pam_unix(sshd:session): session closed for user core Sep 9 01:36:38.935652 systemd[1]: sshd@2-3-10.0.0.22:22-20.101.212.173:47564.service: Deactivated successfully. Sep 9 01:36:38.937037 systemd[1]: session-6.scope: Deactivated successfully. Sep 9 01:36:38.938765 systemd-logind[2497]: Session 6 logged out. Waiting for processes to exit. Sep 9 01:36:38.939439 systemd-logind[2497]: Removed session 6. Sep 9 01:36:38.957899 systemd[1]: Started sshd@3-4097-10.0.0.22:22-20.101.212.173:47566.service - OpenSSH per-connection server daemon (20.101.212.173:47566). Sep 9 01:36:39.068769 sshd[3003]: Accepted publickey for core from 20.101.212.173 port 47566 ssh2: RSA SHA256:DHl1hUxJU9E/jYlbwneRthndozW7c9qspn9/duOHSAk Sep 9 01:36:39.069563 sshd-session[3003]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 01:36:39.073794 systemd-logind[2497]: New session '7' of user 'core' with class 'user' and type 'tty'. Sep 9 01:36:39.088908 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 9 01:36:39.125087 sshd[3007]: Connection closed by 20.101.212.173 port 47566 Sep 9 01:36:39.125881 sshd-session[3003]: pam_unix(sshd:session): session closed for user core Sep 9 01:36:39.128090 systemd[1]: sshd@3-4097-10.0.0.22:22-20.101.212.173:47566.service: Deactivated successfully. Sep 9 01:36:39.129443 systemd[1]: session-7.scope: Deactivated successfully. Sep 9 01:36:39.130091 systemd-logind[2497]: Session 7 logged out. Waiting for processes to exit. Sep 9 01:36:39.131116 systemd-logind[2497]: Removed session 7. Sep 9 01:36:39.159095 systemd[1]: Started sshd@4-4-10.0.0.22:22-20.101.212.173:47572.service - OpenSSH per-connection server daemon (20.101.212.173:47572). Sep 9 01:36:39.271770 sshd[3013]: Accepted publickey for core from 20.101.212.173 port 47572 ssh2: RSA SHA256:DHl1hUxJU9E/jYlbwneRthndozW7c9qspn9/duOHSAk Sep 9 01:36:39.272714 sshd-session[3013]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 01:36:39.276943 systemd-logind[2497]: New session '8' of user 'core' with class 'user' and type 'tty'. Sep 9 01:36:39.282918 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 9 01:36:39.447232 sudo[3018]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 9 01:36:39.447463 sudo[3018]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 01:36:39.456402 sudo[3018]: pam_unix(sudo:session): session closed for user root Sep 9 01:36:39.471076 sshd[3017]: Connection closed by 20.101.212.173 port 47572 Sep 9 01:36:39.472447 sshd-session[3013]: pam_unix(sshd:session): session closed for user core Sep 9 01:36:39.474709 systemd[1]: sshd@4-4-10.0.0.22:22-20.101.212.173:47572.service: Deactivated successfully. Sep 9 01:36:39.476216 systemd[1]: session-8.scope: Deactivated successfully. Sep 9 01:36:39.477482 systemd-logind[2497]: Session 8 logged out. Waiting for processes to exit. Sep 9 01:36:39.478414 systemd-logind[2497]: Removed session 8. Sep 9 01:36:39.501015 systemd[1]: Started sshd@5-5-10.0.0.22:22-20.101.212.173:47582.service - OpenSSH per-connection server daemon (20.101.212.173:47582). Sep 9 01:36:39.612172 sshd[3025]: Accepted publickey for core from 20.101.212.173 port 47582 ssh2: RSA SHA256:DHl1hUxJU9E/jYlbwneRthndozW7c9qspn9/duOHSAk Sep 9 01:36:39.613158 sshd-session[3025]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 01:36:39.617363 systemd-logind[2497]: New session '9' of user 'core' with class 'user' and type 'tty'. Sep 9 01:36:39.622900 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 9 01:36:39.646423 sudo[3031]: 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 Sep 9 01:36:39.646645 sudo[3031]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 01:36:39.647969 sudo[3031]: pam_unix(sudo:session): session closed for user root Sep 9 01:36:39.652791 sudo[3030]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 9 01:36:39.653010 sudo[3030]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 01:36:39.658421 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 9 01:36:39.705000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 9 01:36:39.705000 audit[3055]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffeecf4c530 a2=420 a3=0 items=0 ppid=3036 pid=3055 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) Sep 9 01:36:39.715046 kernel: kauditd_printk_skb: 10 callbacks suppressed Sep 9 01:36:39.715125 augenrules[3055]: No rules Sep 9 01:36:39.715811 kernel: audit: type=1305 audit(1788917799.705:177): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 9 01:36:39.715883 kernel: audit: type=1300 audit(1788917799.705:177): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffeecf4c530 a2=420 a3=0 items=0 ppid=3036 pid=3055 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) Sep 9 01:36:39.705000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 9 01:36:39.718810 kernel: audit: type=1327 audit(1788917799.705:177): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 9 01:36:39.718176 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 01:36:39.718796 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 9 01:36:39.717000 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' Sep 9 01:36:39.721283 sudo[3030]: pam_unix(sudo:session): session closed for user root Sep 9 01:36:39.721899 kernel: audit: type=1130 audit(1788917799.717:178): 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' Sep 9 01:36:39.717000 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' Sep 9 01:36:39.719000 audit[3030]: AUDIT1106 pid=3030 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' Sep 9 01:36:39.726182 kernel: audit: type=1131 audit(1788917799.717:179): 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' Sep 9 01:36:39.726208 kernel: audit: type=1106 audit(1788917799.719:180): pid=3030 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' Sep 9 01:36:39.719000 audit[3030]: AUDIT1104 pid=3030 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' Sep 9 01:36:39.727998 kernel: audit: type=1104 audit(1788917799.719:181): pid=3030 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' Sep 9 01:36:39.735876 sshd[3029]: Connection closed by 20.101.212.173 port 47582 Sep 9 01:36:39.736865 sshd-session[3025]: pam_unix(sshd:session): session closed for user core Sep 9 01:36:39.735000 audit[3025]: AUDIT1106 pid=3025 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 9 01:36:39.740425 systemd[1]: sshd@5-5-10.0.0.22:22-20.101.212.173:47582.service: Deactivated successfully. Sep 9 01:36:39.742567 systemd[1]: session-9.scope: Deactivated successfully. Sep 9 01:36:39.735000 audit[3025]: AUDIT1104 pid=3025 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 9 01:36:39.746892 kernel: audit: type=1106 audit(1788917799.735:182): pid=3025 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 9 01:36:39.746920 kernel: audit: type=1104 audit(1788917799.735:183): pid=3025 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 9 01:36:39.739000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-5-10.0.0.22:22-20.101.212.173:47582 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.749696 kernel: audit: type=1131 audit(1788917799.739:184): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-5-10.0.0.22:22-20.101.212.173:47582 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.750945 systemd-logind[2497]: Session 9 logged out. Waiting for processes to exit. Sep 9 01:36:39.751590 systemd-logind[2497]: Removed session 9. Sep 9 01:36:39.758000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4098-10.0.0.22:22-20.101.212.173:47584 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.760131 systemd[1]: Started sshd@6-4098-10.0.0.22:22-20.101.212.173:47584.service - OpenSSH per-connection server daemon (20.101.212.173:47584). Sep 9 01:36:39.867000 audit[3064]: AUDIT1101 pid=3064 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_time,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 9 01:36:39.868907 sshd[3064]: Accepted publickey for core from 20.101.212.173 port 47584 ssh2: RSA SHA256:DHl1hUxJU9E/jYlbwneRthndozW7c9qspn9/duOHSAk Sep 9 01:36:39.867000 audit[3064]: AUDIT1103 pid=3064 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 9 01:36:39.867000 audit[3064]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7ffcecf1da00 a2=3 a3=0 items=0 ppid=1 pid=3064 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) Sep 9 01:36:39.867000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Sep 9 01:36:39.869981 sshd-session[3064]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 01:36:39.874152 systemd-logind[2497]: New session '10' of user 'core' with class 'user' and type 'tty'. Sep 9 01:36:39.883916 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 9 01:36:39.884000 audit[3064]: AUDIT1105 pid=3064 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 9 01:36:39.885000 audit[3068]: AUDIT1103 pid=3068 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 9 01:36:39.905000 audit[3071]: AUDIT1101 pid=3071 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.907651 sudo[3071]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/tee /etc/flatcar/update.conf Sep 9 01:36:39.906000 audit[3071]: AUDIT1110 pid=3071 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.906000 audit[3071]: AUDIT1105 pid=3071 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.907948 sudo[3071]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 01:36:39.932611 sudo[3071]: pam_unix(sudo:session): session closed for user root Sep 9 01:36:39.930000 audit[3071]: AUDIT1106 pid=3071 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.930000 audit[3071]: AUDIT1104 pid=3071 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.934845 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 9 01:36:39.944731 motdgen[3079]: /oem/oem-release: line 2: Azure: command not found Sep 9 01:36:39.948125 sshd[3068]: Connection closed by 20.101.212.173 port 47584 Sep 9 01:36:39.946000 audit[3064]: AUDIT1106 pid=3064 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 9 01:36:39.946000 audit[3064]: AUDIT1104 pid=3064 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 9 01:36:39.947933 sshd-session[3064]: pam_unix(sshd:session): session closed for user core Sep 9 01:36:39.950119 systemd[1]: sshd@6-4098-10.0.0.22:22-20.101.212.173:47584.service: Deactivated successfully. Sep 9 01:36:39.948000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4098-10.0.0.22:22-20.101.212.173:47584 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.951528 systemd[1]: motdgen.service: Deactivated successfully. Sep 9 01:36:39.950000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=motdgen comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.951798 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 9 01:36:39.950000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=motdgen comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 01:36:39.952386 systemd[1]: session-10.scope: Deactivated successfully. Sep 9 01:36:39.954397 systemd-logind[2497]: Session 10 logged out. Waiting for processes to exit. Sep 9 01:36:39.955243 systemd-logind[2497]: Removed session 10.