Sep 4 13:16:36.435690 kernel: Linux version 6.18.45-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 Fri Sep 4 10:58:52 -00 2026 Sep 4 13:16:36.435748 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=2024536d78f0c0d715f27a5f22c06349f73a8b545539c049e5441f14752dcdfc Sep 4 13:16:36.435763 kernel: BIOS-provided physical RAM map: Sep 4 13:16:36.435774 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Sep 4 13:16:36.435786 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Sep 4 13:16:36.435795 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000044fdfff] usable Sep 4 13:16:36.435807 kernel: BIOS-e820: [mem 0x00000000044fe000-0x00000000048fdfff] reserved Sep 4 13:16:36.435817 kernel: BIOS-e820: [mem 0x00000000048fe000-0x000000003ff1efff] usable Sep 4 13:16:36.435855 kernel: BIOS-e820: [mem 0x000000003ff1f000-0x000000003ffc8fff] reserved Sep 4 13:16:36.435865 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Sep 4 13:16:36.435875 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Sep 4 13:16:36.435885 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Sep 4 13:16:36.435897 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable Sep 4 13:16:36.435905 kernel: printk: legacy bootconsole [earlyser0] enabled Sep 4 13:16:36.435915 kernel: NX (Execute Disable) protection: active Sep 4 13:16:36.435926 kernel: APIC: Static calls initialized Sep 4 13:16:36.435936 kernel: efi: EFI v2.7 by Microsoft Sep 4 13:16:36.435966 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff88000 SMBIOS 3.0=0x3ff86000 MEMATTR=0x3ea8c798 RNG=0x3ffd2018 Sep 4 13:16:36.435977 kernel: random: crng init done Sep 4 13:16:36.435988 kernel: secureboot: Secure boot disabled Sep 4 13:16:36.435998 kernel: SMBIOS 3.1.0 present. Sep 4 13:16:36.436007 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Sep 4 13:16:36.436015 kernel: DMI: Memory slots populated: 2/2 Sep 4 13:16:36.436023 kernel: Hypervisor detected: Microsoft Hyper-V Sep 4 13:16:36.436034 kernel: Hyper-V: privilege flags low 0xae7f, high 0x3b8030, ext 0x62, hints 0x9e4e24, misc 0xe0bed7b2 Sep 4 13:16:36.436045 kernel: Hyper-V: Nested features: 0x3e0101 Sep 4 13:16:36.436055 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Sep 4 13:16:36.436066 kernel: Hyper-V: Using hypercall for remote TLB flush Sep 4 13:16:36.436076 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Sep 4 13:16:36.436085 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Sep 4 13:16:36.436095 kernel: tsc: Detected 2300.000 MHz processor Sep 4 13:16:36.436106 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 4 13:16:36.436121 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 4 13:16:36.436135 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x10000000000 Sep 4 13:16:36.436148 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Sep 4 13:16:36.436162 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 4 13:16:36.436180 kernel: e820: update [mem 0x48000000-0xffffffff] usable ==> reserved Sep 4 13:16:36.436191 kernel: last_pfn = 0x40000 max_arch_pfn = 0x10000000000 Sep 4 13:16:36.436205 kernel: Using GB pages for direct mapping Sep 4 13:16:36.436216 kernel: ACPI: Early table checksum verification disabled Sep 4 13:16:36.436231 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Sep 4 13:16:36.436246 kernel: ACPI: XSDT 0x000000003FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 13:16:36.436256 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 13:16:36.436269 kernel: ACPI: DSDT 0x000000003FFD6000 01E22B (v02 MSFTVM DSDT01 00000001 INTL 20230628) Sep 4 13:16:36.436279 kernel: ACPI: FACS 0x000000003FFFE000 000040 Sep 4 13:16:36.436293 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 13:16:36.436302 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 13:16:36.436313 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 13:16:36.436327 kernel: ACPI: APIC 0x000000003FFD5000 000058 (v05 HVLITE HVLITETB 00000000 MSHV 00000000) Sep 4 13:16:36.436338 kernel: ACPI: SRAT 0x000000003FFD4000 0000A0 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) Sep 4 13:16:36.436350 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 13:16:36.436364 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Sep 4 13:16:36.436376 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff422a] Sep 4 13:16:36.436390 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Sep 4 13:16:36.436408 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Sep 4 13:16:36.436424 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Sep 4 13:16:36.436433 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Sep 4 13:16:36.436447 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5057] Sep 4 13:16:36.436460 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd409f] Sep 4 13:16:36.436471 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Sep 4 13:16:36.436482 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Sep 4 13:16:36.436495 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] Sep 4 13:16:36.436506 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00001000-0x2bfffffff] Sep 4 13:16:36.436520 kernel: NODE_DATA(0) allocated [mem 0x2bfff8d80-0x2bfffffff] Sep 4 13:16:36.436531 kernel: Zone ranges: Sep 4 13:16:36.436542 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 4 13:16:36.436555 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Sep 4 13:16:36.436563 kernel: Normal [mem 0x0000000100000000-0x00000002bfffffff] Sep 4 13:16:36.436575 kernel: Device empty Sep 4 13:16:36.436584 kernel: Movable zone start for each node Sep 4 13:16:36.436597 kernel: Early memory node ranges Sep 4 13:16:36.436605 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Sep 4 13:16:36.436616 kernel: node 0: [mem 0x0000000000100000-0x00000000044fdfff] Sep 4 13:16:36.436627 kernel: node 0: [mem 0x00000000048fe000-0x000000003ff1efff] Sep 4 13:16:36.436638 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Sep 4 13:16:36.436651 kernel: node 0: [mem 0x0000000100000000-0x00000002bfffffff] Sep 4 13:16:36.436663 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff] Sep 4 13:16:36.436672 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 4 13:16:36.436683 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Sep 4 13:16:36.436692 kernel: On node 0, zone DMA32: 1024 pages in unavailable ranges Sep 4 13:16:36.436704 kernel: On node 0, zone DMA32: 224 pages in unavailable ranges Sep 4 13:16:36.436715 kernel: ACPI: PM-Timer IO Port: 0x408 Sep 4 13:16:36.436727 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Sep 4 13:16:36.436738 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Sep 4 13:16:36.436750 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 4 13:16:36.436758 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Sep 4 13:16:36.436769 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Sep 4 13:16:36.436780 kernel: TSC deadline timer available Sep 4 13:16:36.436789 kernel: CPU topo: Max. logical packages: 1 Sep 4 13:16:36.436797 kernel: CPU topo: Max. logical dies: 1 Sep 4 13:16:36.436808 kernel: CPU topo: Max. dies per package: 1 Sep 4 13:16:36.436819 kernel: CPU topo: Max. threads per core: 2 Sep 4 13:16:36.436828 kernel: CPU topo: Num. cores per package: 1 Sep 4 13:16:36.436842 kernel: CPU topo: Num. threads per package: 2 Sep 4 13:16:36.436853 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs Sep 4 13:16:36.436861 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Sep 4 13:16:36.436870 kernel: Booting paravirtualized kernel on Hyper-V Sep 4 13:16:36.436881 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Sep 4 13:16:36.436890 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Sep 4 13:16:36.436901 kernel: percpu: Embedded 56 pages/cpu s190680 r8192 d30504 u1048576 Sep 4 13:16:36.436909 kernel: pcpu-alloc: s190680 r8192 d30504 u1048576 alloc=1*2097152 Sep 4 13:16:36.436921 kernel: pcpu-alloc: [0] 0 1 Sep 4 13:16:36.436930 kernel: Hyper-V: PV spinlocks enabled Sep 4 13:16:36.436960 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Sep 4 13:16:36.436974 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=2024536d78f0c0d715f27a5f22c06349f73a8b545539c049e5441f14752dcdfc Sep 4 13:16:36.436984 kernel: printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes Sep 4 13:16:36.436994 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Sep 4 13:16:36.437004 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 4 13:16:36.437013 kernel: software IO TLB: area num 2. Sep 4 13:16:36.437025 kernel: Fallback order for Node 0: 0 Sep 4 13:16:36.437038 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2095807 Sep 4 13:16:36.437047 kernel: Policy zone: Normal Sep 4 13:16:36.437056 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 4 13:16:36.437066 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 4 13:16:36.437077 kernel: ftrace: allocating 41463 entries in 164 pages Sep 4 13:16:36.437090 kernel: ftrace: allocated 164 pages with 3 groups Sep 4 13:16:36.437101 kernel: Dynamic Preempt: voluntary Sep 4 13:16:36.437114 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 4 13:16:36.437133 kernel: rcu: RCU event tracing is enabled. Sep 4 13:16:36.437143 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 4 13:16:36.437158 kernel: Trampoline variant of Tasks RCU enabled. Sep 4 13:16:36.437169 kernel: Rude variant of Tasks RCU enabled. Sep 4 13:16:36.437178 kernel: Tracing variant of Tasks RCU enabled. Sep 4 13:16:36.437189 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 4 13:16:36.437199 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 4 13:16:36.437209 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 4 13:16:36.437220 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 4 13:16:36.437232 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 4 13:16:36.437244 kernel: Using NULL legacy PIC Sep 4 13:16:36.437255 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0 Sep 4 13:16:36.437267 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 4 13:16:36.437279 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 4 13:16:36.437288 kernel: Console: colour dummy device 80x25 Sep 4 13:16:36.437298 kernel: printk: legacy console [tty1] enabled Sep 4 13:16:36.437308 kernel: printk: legacy console [ttyS0] enabled Sep 4 13:16:36.437317 kernel: printk: legacy bootconsole [earlyser0] disabled Sep 4 13:16:36.437327 kernel: ACPI: Core revision 20250807 Sep 4 13:16:36.437337 kernel: Failed to register legacy timer interrupt Sep 4 13:16:36.437348 kernel: APIC: Switch to symmetric I/O mode setup Sep 4 13:16:36.437363 kernel: x2apic enabled Sep 4 13:16:36.437376 kernel: APIC: Switched APIC routing to: physical x2apic Sep 4 13:16:36.437387 kernel: Hyper-V: Host Build 10.0.26100.1684-1-0 Sep 4 13:16:36.437399 kernel: Hyper-V: enabling crash_kexec_post_notifiers Sep 4 13:16:36.437408 kernel: Hyper-V: Using IPI hypercalls Sep 4 13:16:36.437417 kernel: APIC: send_IPI() replaced with hv_send_ipi() Sep 4 13:16:36.437428 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Sep 4 13:16:36.437438 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Sep 4 13:16:36.437448 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Sep 4 13:16:36.437457 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Sep 4 13:16:36.437467 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Sep 4 13:16:36.437477 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212735223b2, max_idle_ns: 440795277976 ns Sep 4 13:16:36.437487 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4600.00 BogoMIPS (lpj=2300000) Sep 4 13:16:36.437502 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Sep 4 13:16:36.437513 kernel: CET detected: Indirect Branch Tracking enabled Sep 4 13:16:36.437523 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Sep 4 13:16:36.437532 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Sep 4 13:16:36.437542 kernel: mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto Sep 4 13:16:36.437552 kernel: Speculative Store Bypass: Vulnerable Sep 4 13:16:36.437562 kernel: Spectre V2 : Mitigation: Retpolines Sep 4 13:16:36.437572 kernel: RETBleed: Vulnerable Sep 4 13:16:36.437583 kernel: ITS: Mitigation: Aligned branch/return thunks Sep 4 13:16:36.437596 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 4 13:16:36.437606 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Sep 4 13:16:36.437616 kernel: active return thunk: its_return_thunk Sep 4 13:16:36.437626 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Sep 4 13:16:36.437637 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Sep 4 13:16:36.437649 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Sep 4 13:16:36.437659 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Sep 4 13:16:36.437667 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Sep 4 13:16:36.437676 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Sep 4 13:16:36.437685 kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' Sep 4 13:16:36.437697 kernel: x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' Sep 4 13:16:36.437707 kernel: x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' Sep 4 13:16:36.437716 kernel: x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' Sep 4 13:16:36.437726 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Sep 4 13:16:36.437736 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Sep 4 13:16:36.437745 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Sep 4 13:16:36.437754 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Sep 4 13:16:36.437767 kernel: x86/fpu: xstate_offset[11]: 2432, xstate_sizes[11]: 16 Sep 4 13:16:36.437825 kernel: x86/fpu: xstate_offset[12]: 2448, xstate_sizes[12]: 24 Sep 4 13:16:36.437840 kernel: x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 Sep 4 13:16:36.437851 kernel: x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 Sep 4 13:16:36.437864 kernel: x86/fpu: Enabled xstate features 0x618e7, context size is 10752 bytes, using 'compacted' format. Sep 4 13:16:36.437874 kernel: Freeing SMP alternatives memory: 40K Sep 4 13:16:36.437883 kernel: pid_max: default: 32768 minimum: 301 Sep 4 13:16:36.437894 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 4 13:16:36.437904 kernel: landlock: Up and running. Sep 4 13:16:36.437913 kernel: SELinux: Initializing. Sep 4 13:16:36.437922 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Sep 4 13:16:36.437932 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Sep 4 13:16:36.437963 kernel: smpboot: CPU0: Intel INTEL(R) XEON(R) PLATINUM 8573C (family: 0x6, model: 0xcf, stepping: 0x2) Sep 4 13:16:36.437972 kernel: Performance Events: unsupported CPU family 6 model 207 no PMU driver, software events only. Sep 4 13:16:36.437985 kernel: signal: max sigframe size: 11952 Sep 4 13:16:36.437994 kernel: rcu: Hierarchical SRCU implementation. Sep 4 13:16:36.438004 kernel: rcu: Max phase no-delay instances is 400. Sep 4 13:16:36.438014 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 4 13:16:36.438023 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Sep 4 13:16:36.438032 kernel: smp: Bringing up secondary CPUs ... Sep 4 13:16:36.438044 kernel: smpboot: x86: Booting SMP configuration: Sep 4 13:16:36.438054 kernel: .... node #0, CPUs: #1 Sep 4 13:16:36.438066 kernel: smp: Brought up 1 node, 2 CPUs Sep 4 13:16:36.438076 kernel: smpboot: Total of 2 processors activated (9200.00 BogoMIPS) Sep 4 13:16:36.438087 kernel: Memory: 8074020K/8383228K available (14045K kernel code, 2496K rwdata, 32732K rodata, 17044K init, 948K bss, 303932K reserved, 0K cma-reserved) Sep 4 13:16:36.438097 kernel: devtmpfs: initialized Sep 4 13:16:36.438107 kernel: x86/mm: Memory block size: 128MB Sep 4 13:16:36.438117 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Sep 4 13:16:36.438127 kernel: posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) Sep 4 13:16:36.438139 kernel: futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). Sep 4 13:16:36.438149 kernel: pinctrl core: initialized pinctrl subsystem Sep 4 13:16:36.438159 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 4 13:16:36.438170 kernel: audit: initializing netlink subsys (disabled) Sep 4 13:16:36.438180 kernel: audit: type=2000 audit(1788527789.109:1): state=initialized audit_enabled=0 res=1 Sep 4 13:16:36.438189 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 4 13:16:36.438199 kernel: cpuidle: using governor menu Sep 4 13:16:36.438214 kernel: efi: Freeing EFI boot services memory: 20364K Sep 4 13:16:36.438223 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 4 13:16:36.438233 kernel: dca service started, version 1.12.1 Sep 4 13:16:36.438243 kernel: e820: reserve RAM buffer [mem 0x044fe000-0x07ffffff] Sep 4 13:16:36.438252 kernel: e820: reserve RAM buffer [mem 0x3ff1f000-0x3fffffff] Sep 4 13:16:36.438262 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 4 13:16:36.438274 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 4 13:16:36.438286 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Sep 4 13:16:36.438295 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 4 13:16:36.438304 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Sep 4 13:16:36.438314 kernel: ACPI: Added _OSI(Module Device) Sep 4 13:16:36.438323 kernel: ACPI: Added _OSI(Processor Device) Sep 4 13:16:36.438332 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 4 13:16:36.438341 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 4 13:16:36.438353 kernel: ACPI: Interpreter enabled Sep 4 13:16:36.438363 kernel: ACPI: PM: (supports S0 S5) Sep 4 13:16:36.438372 kernel: ACPI: Using IOAPIC for interrupt routing Sep 4 13:16:36.438382 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 4 13:16:36.438392 kernel: PCI: Ignoring E820 reservations for host bridge windows Sep 4 13:16:36.438402 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Sep 4 13:16:36.438412 kernel: iommu: Default domain type: Translated Sep 4 13:16:36.438424 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Sep 4 13:16:36.438434 kernel: efivars: Registered efivars operations Sep 4 13:16:36.438444 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Sep 4 13:16:36.438454 kernel: hv_vmbus: Vmbus version:5.3 Sep 4 13:16:36.438464 kernel: PCI: Using ACPI for IRQ routing Sep 4 13:16:36.438474 kernel: PCI: System does not support PCI Sep 4 13:16:36.438485 kernel: vgaarb: loaded Sep 4 13:16:36.438497 kernel: clocksource: Switched to clocksource tsc-early Sep 4 13:16:36.438507 kernel: VFS: Disk quotas dquot_6.6.0 Sep 4 13:16:36.438518 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 4 13:16:36.438528 kernel: pnp: PnP ACPI init Sep 4 13:16:36.438538 kernel: pnp: PnP ACPI: found 3 devices Sep 4 13:16:36.438548 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 4 13:16:36.438559 kernel: NET: Registered PF_INET protocol family Sep 4 13:16:36.438571 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) Sep 4 13:16:36.438580 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) Sep 4 13:16:36.438589 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 4 13:16:36.438598 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 4 13:16:36.438608 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Sep 4 13:16:36.438617 kernel: TCP: Hash tables configured (established 65536 bind 65536) Sep 4 13:16:36.438627 kernel: UDP hash table entries: 4096 (order: 6, 262144 bytes, linear) Sep 4 13:16:36.438639 kernel: UDP-Lite hash table entries: 4096 (order: 6, 262144 bytes, linear) Sep 4 13:16:36.438649 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 4 13:16:36.438659 kernel: NET: Registered PF_XDP protocol family Sep 4 13:16:36.438668 kernel: PCI: CLS 0 bytes, default 64 Sep 4 13:16:36.438677 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Sep 4 13:16:36.438687 kernel: software IO TLB: mapped [mem 0x000000003a95c000-0x000000003e95c000] (64MB) Sep 4 13:16:36.438695 kernel: RAPL PMU: API unit is 2^-32 Joules, 1 fixed counters, 10737418240 ms ovfl timer Sep 4 13:16:36.438705 kernel: RAPL PMU: hw unit of domain psys 2^-0 Joules Sep 4 13:16:36.438720 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212735223b2, max_idle_ns: 440795277976 ns Sep 4 13:16:36.438729 kernel: clocksource: Switched to clocksource tsc Sep 4 13:16:36.438739 kernel: Initialise system trusted keyrings Sep 4 13:16:36.438749 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 Sep 4 13:16:36.438759 kernel: Key type asymmetric registered Sep 4 13:16:36.438768 kernel: Asymmetric key parser 'x509' registered Sep 4 13:16:36.438781 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 4 13:16:36.438791 kernel: io scheduler mq-deadline registered Sep 4 13:16:36.438800 kernel: io scheduler kyber registered Sep 4 13:16:36.438810 kernel: io scheduler bfq registered Sep 4 13:16:36.438819 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Sep 4 13:16:36.438828 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 4 13:16:36.438838 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Sep 4 13:16:36.438849 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Sep 4 13:16:36.438858 kernel: serial8250: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A Sep 4 13:16:36.438867 kernel: i8042: PNP: No PS/2 controller found. Sep 4 13:16:36.438876 kernel: hv_vmbus: registering driver hyperv_keyboard Sep 4 13:16:36.439110 kernel: rtc_cmos 00:02: registered as rtc0 Sep 4 13:16:36.439128 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 Sep 4 13:16:36.439251 kernel: rtc_cmos 00:02: setting system clock to 2026-09-04T13:16:29 UTC (1788527789) Sep 4 13:16:36.439379 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Sep 4 13:16:36.439392 kernel: intel_pstate: Intel P-state driver initializing Sep 4 13:16:36.439403 kernel: efifb: probing for efifb Sep 4 13:16:36.439414 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Sep 4 13:16:36.439423 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Sep 4 13:16:36.439433 kernel: efifb: scrolling: redraw Sep 4 13:16:36.439444 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Sep 4 13:16:36.439453 kernel: Console: switching to colour frame buffer device 128x48 Sep 4 13:16:36.439463 kernel: fb0: EFI VGA frame buffer device Sep 4 13:16:36.439472 kernel: pstore: Using crash dump compression: deflate Sep 4 13:16:36.439482 kernel: pstore: Registered efi_pstore as persistent store backend Sep 4 13:16:36.439492 kernel: NET: Registered PF_INET6 protocol family Sep 4 13:16:36.439502 kernel: Segment Routing with IPv6 Sep 4 13:16:36.439512 kernel: In-situ OAM (IOAM) with IPv6 Sep 4 13:16:36.439523 kernel: NET: Registered PF_PACKET protocol family Sep 4 13:16:36.439532 kernel: Key type dns_resolver registered Sep 4 13:16:36.439541 kernel: IPI shorthand broadcast: enabled Sep 4 13:16:36.439557 kernel: sched_clock: Marking stable (1191006370, 110380385)->(1689055664, -387668909) Sep 4 13:16:36.439566 kernel: registered taskstats version 1 Sep 4 13:16:36.439575 kernel: Loading compiled-in X.509 certificates Sep 4 13:16:36.439586 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.18.45-flatcar: f50bbb86a9f452a80654c961fdfea3dd85722c64' Sep 4 13:16:36.439598 kernel: Demotion targets for Node 0: null Sep 4 13:16:36.439607 kernel: Key type .fscrypt registered Sep 4 13:16:36.439617 kernel: Key type fscrypt-provisioning registered Sep 4 13:16:36.439627 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 4 13:16:36.439638 kernel: ima: Allocated hash algorithm: sha1 Sep 4 13:16:36.439647 kernel: ima: No architecture policies found Sep 4 13:16:36.439657 kernel: clk: Disabling unused clocks Sep 4 13:16:36.439668 kernel: Freeing unused kernel image (initmem) memory: 17044K Sep 4 13:16:36.439677 kernel: Write protecting the kernel read-only data: 47104k Sep 4 13:16:36.439687 kernel: Freeing unused kernel image (text/rodata gap) memory: 288K Sep 4 13:16:36.439696 kernel: Freeing unused kernel image (rodata/data gap) memory: 36K Sep 4 13:16:36.439705 kernel: Run /init as init process Sep 4 13:16:36.439714 kernel: with arguments: Sep 4 13:16:36.439723 kernel: /init Sep 4 13:16:36.439734 kernel: with environment: Sep 4 13:16:36.439744 kernel: HOME=/ Sep 4 13:16:36.439753 kernel: TERM=linux Sep 4 13:16:36.439763 kernel: hv_vmbus: registering driver hv_pci Sep 4 13:16:36.440045 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI VMBus probing: Using version 0x10004 Sep 4 13:16:36.440210 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI host bridge to bus c05b:00 Sep 4 13:16:36.440384 kernel: pci_bus c05b:00: root bus resource [mem 0xfc0000000-0xfc007ffff window] Sep 4 13:16:36.440550 kernel: pci_bus c05b:00: No busn resource found for root bus, will use [bus 00-ff] Sep 4 13:16:36.440732 kernel: pci c05b:00:00.0: [1414:00a9] type 00 class 0x010802 PCIe Endpoint Sep 4 13:16:36.440894 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit] Sep 4 13:16:36.441081 kernel: pci_bus c05b:00: busn_res: [bus 00-ff] end is updated to 00 Sep 4 13:16:36.441251 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit]: assigned Sep 4 13:16:36.441270 kernel: pps_core: LinuxPPS API ver. 1 registered Sep 4 13:16:36.441281 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 4 13:16:36.441465 kernel: nvme nvme0: pci function c05b:00:00.0 Sep 4 13:16:36.441641 kernel: nvme c05b:00:00.0: enabling device (0000 -> 0002) Sep 4 13:16:36.441654 kernel: PTP clock support registered Sep 4 13:16:36.441792 kernel: nvme nvme0: 2/0/0 default/read/poll queues Sep 4 13:16:36.441808 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 4 13:16:36.441819 kernel: hv_utils: Registering HyperV Utility Driver Sep 4 13:16:36.441829 kernel: hv_vmbus: registering driver hv_utils Sep 4 13:16:36.441839 kernel: hv_utils: Shutdown IC version 3.2 Sep 4 13:16:36.441850 kernel: hv_utils: Heartbeat IC version 3.0 Sep 4 13:16:36.441860 kernel: hv_utils: TimeSync IC version 4.0 Sep 4 13:16:36.441873 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 4 13:16:36.441882 kernel: hv_vmbus: registering driver hid_hyperv Sep 4 13:16:36.441893 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Sep 4 13:16:36.442058 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Sep 4 13:16:36.442073 kernel: SCSI subsystem initialized Sep 4 13:16:36.442083 kernel: hv_vmbus: registering driver hv_storvsc Sep 4 13:16:36.442264 kernel: scsi host0: storvsc_host_t Sep 4 13:16:36.442442 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Sep 4 13:16:36.442607 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Sep 4 13:16:36.442633 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 4 13:16:36.442790 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Sep 4 13:16:36.442804 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 4 13:16:36.442817 kernel: device-mapper: uevent: version 1.0.3 Sep 4 13:16:36.442828 kernel: device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev Sep 4 13:16:36.442838 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:36.442849 kernel: raid6: avx512x4 gen() 42208 MB/s Sep 4 13:16:36.442859 kernel: raid6: avx512x2 gen() 42143 MB/s Sep 4 13:16:36.442870 kernel: raid6: avx512x1 gen() 25098 MB/s Sep 4 13:16:36.442880 kernel: raid6: avx2x4 gen() 34045 MB/s Sep 4 13:16:36.442892 kernel: raid6: avx2x2 gen() 35384 MB/s Sep 4 13:16:36.442901 kernel: raid6: avx2x1 gen() 29441 MB/s Sep 4 13:16:36.442910 kernel: raid6: using algorithm avx512x4 gen() 42208 MB/s Sep 4 13:16:36.442920 kernel: raid6: .... xor() 7259 MB/s, rmw enabled Sep 4 13:16:36.442931 kernel: raid6: using avx512x2 recovery algorithm Sep 4 13:16:36.442967 kernel: xor: automatically using best checksumming function avx Sep 4 13:16:36.442978 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 4 13:16:36.442991 kernel: BTRFS: device fsid b9234b0d-0a5f-4030-a7c8-dcd6842e928e devid 1 transid 38 /dev/mapper/usr (254:0) scanned by mount (159) Sep 4 13:16:36.443001 kernel: BTRFS info (device dm-0): first mount of filesystem b9234b0d-0a5f-4030-a7c8-dcd6842e928e Sep 4 13:16:36.443011 kernel: BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm Sep 4 13:16:36.443020 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Sep 4 13:16:36.443036 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Sep 4 13:16:36.443046 kernel: BTRFS info (device dm-0 state E): enabling free space tree Sep 4 13:16:36.443056 kernel: loop: module loaded Sep 4 13:16:36.443068 kernel: loop0: detected capacity change from 0 to 123040 Sep 4 13:16:36.443079 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 4 13:16:36.443091 systemd[1]: Successfully made /usr/ read-only. Sep 4 13:16:36.443106 systemd[1]: systemd 260.1 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 4 13:16:36.443117 systemd[1]: Detected virtualization microsoft. Sep 4 13:16:36.443127 systemd[1]: Detected architecture x86-64. Sep 4 13:16:36.443139 systemd[1]: Running in initrd. Sep 4 13:16:36.443151 systemd[1]: Initializing machine ID from random generator. Sep 4 13:16:36.443161 systemd[1]: No hostname configured, using default hostname. Sep 4 13:16:36.443171 systemd[1]: Hostname set to . Sep 4 13:16:36.443183 (gene[193]: '/usr/lib/systemd/system-generators/dracut-crypt-generator' failed with exit status 2. Sep 4 13:16:36.443195 systemd[1]: Queued start job for default target initrd.target. Sep 4 13:16:36.443205 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 13:16:36.443215 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 13:16:36.443226 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 4 13:16:36.443237 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 13:16:36.443250 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 4 13:16:36.443262 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 4 13:16:36.443272 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 4 13:16:36.443283 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 13:16:36.443294 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 13:16:36.443305 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 4 13:16:36.443318 systemd[1]: Reached target paths.target - Path Units. Sep 4 13:16:36.443329 systemd[1]: Reached target slices.target - Slice Units. Sep 4 13:16:36.443340 systemd[1]: Reached target swap.target - Swaps. Sep 4 13:16:36.443351 systemd[1]: Reached target timers.target - Timer Units. Sep 4 13:16:36.443362 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 13:16:36.443372 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 13:16:36.443383 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 13:16:36.443395 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 4 13:16:36.443406 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 4 13:16:36.443416 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 4 13:16:36.443428 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 4 13:16:36.443438 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 4 13:16:36.443449 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 13:16:36.443459 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 13:16:36.443470 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 13:16:36.443480 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Sep 4 13:16:36.443491 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 4 13:16:36.443501 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 13:16:36.443511 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 4 13:16:36.443522 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Sep 4 13:16:36.443534 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 13:16:36.443546 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 13:16:36.443557 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 4 13:16:36.443568 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 13:16:36.443608 systemd-journald[349]: Collecting audit messages is enabled. Sep 4 13:16:36.443638 systemd-journald[349]: Journal started Sep 4 13:16:36.443666 systemd-journald[349]: Runtime Journal (/run/log/journal/21b0c667c99a4f00be7d786a70c73887) is 8M, max 158.5M, 150.5M free. Sep 4 13:16:36.396882 systemd-modules-load[352]: Using 2 probe threads Sep 4 13:16:36.448961 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 13:16:36.447000 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 4 13:16:36.452991 kernel: audit: type=1130 audit(1788527796.447:2): 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 4 13:16:36.453002 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 4 13:16:36.453000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:36.457978 kernel: audit: type=1130 audit(1788527796.453:3): 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 4 13:16:36.458000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:36.459083 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 13:16:36.465853 kernel: audit: type=1130 audit(1788527796.458:4): 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 4 13:16:36.466808 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 4 13:16:36.468970 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 13:16:36.466000 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 4 13:16:36.474007 kernel: audit: type=1130 audit(1788527796.466:5): 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 4 13:16:36.477218 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 13:16:36.488025 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 13:16:36.561289 systemd-tmpfiles[382]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Sep 4 13:16:36.561370 systemd-tmpfiles[382]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 4 13:16:36.568538 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 13:16:36.573000 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 4 13:16:36.578669 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 13:16:36.584958 kernel: audit: type=1130 audit(1788527796.573:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:36.586034 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 13:16:36.579000 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 4 13:16:36.590624 kernel: audit: type=1130 audit(1788527796.579:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:36.602969 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 4 13:16:36.624401 systemd-modules-load[352]: Inserted module 'br_netfilter' Sep 4 13:16:36.625047 kernel: Bridge firewalling registered Sep 4 13:16:36.633867 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 13:16:36.637000 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 4 13:16:36.635794 systemd-vconsole-setup[356]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 4 13:16:36.639585 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 13:16:36.644199 kernel: audit: type=1130 audit(1788527796.637:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:36.649000 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 4 13:16:36.654197 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 13:16:36.654000 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 4 13:16:36.660902 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 13:16:36.664081 kernel: audit: type=1130 audit(1788527796.649:9): 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 4 13:16:36.664165 kernel: audit: type=1130 audit(1788527796.654:10): 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 4 13:16:36.667246 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 13:16:36.684659 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 4 13:16:36.686145 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 13:16:36.688000 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 4 13:16:36.694247 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 13:16:36.688000 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 4 13:16:36.694000 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 4 13:16:36.700104 kernel: audit: type=1130 audit(1788527796.688:11): 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 4 13:16:36.700247 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 4 13:16:36.703000 audit: BPF prog-id=5 op=LOAD Sep 4 13:16:36.706050 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 13:16:36.721469 dracut-cmdline[416]: dracut-111 Sep 4 13:16:36.725346 dracut-cmdline[416]: 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=2024536d78f0c0d715f27a5f22c06349f73a8b545539c049e5441f14752dcdfc Sep 4 13:16:36.855853 systemd-resolved[418]: Positive Trust Anchors: Sep 4 13:16:36.857558 systemd-resolved[418]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 13:16:36.860613 systemd-resolved[418]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 4 13:16:36.860656 systemd-resolved[418]: 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 4 13:16:37.086162 systemd-resolved[418]: Defaulting to hostname 'linux'. Sep 4 13:16:37.088051 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 13:16:37.093000 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 4 13:16:37.094599 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 13:16:37.101051 kernel: Loading iSCSI transport class v2.0-870. Sep 4 13:16:37.142082 kernel: iscsi: registered transport (tcp) Sep 4 13:16:37.227157 kernel: iscsi: registered transport (qla4xxx) Sep 4 13:16:37.227205 kernel: QLogic iSCSI HBA Driver Sep 4 13:16:37.285619 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Sep 4 13:16:37.301452 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 4 13:16:37.304000 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 4 13:16:37.306761 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 4 13:16:37.333842 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 4 13:16:37.334000 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 4 13:16:37.335000 audit: BPF prog-id=6 op=LOAD Sep 4 13:16:37.335000 audit: BPF prog-id=7 op=LOAD Sep 4 13:16:37.338298 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 13:16:37.408888 systemd-udevd[559]: Using default interface naming scheme 'v260'. Sep 4 13:16:37.444393 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 13:16:37.443000 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 4 13:16:37.454076 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 4 13:16:37.459000 audit: BPF prog-id=8 op=LOAD Sep 4 13:16:37.473042 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 4 13:16:37.490891 dracut-pre-trigger[575]: rd.md=0: removing MD RAID activation Sep 4 13:16:37.521483 systemd-networkd[584]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Sep 4 13:16:37.527688 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 13:16:37.529000 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 4 13:16:37.530264 systemd-networkd[584]: lo: Link UP Sep 4 13:16:37.534000 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 4 13:16:37.530268 systemd-networkd[584]: lo: Gained carrier Sep 4 13:16:37.530817 systemd[1]: Started systemd-networkd.service - Network Management. Sep 4 13:16:37.535418 systemd[1]: Reached target network.target - Network. Sep 4 13:16:37.542020 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 13:16:37.607163 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 13:16:37.612000 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 4 13:16:37.617539 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 4 13:16:37.695964 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#221 cmd 0x85 status: scsi 0x2 srb 0x6 host 0xc0000001 Sep 4 13:16:37.733964 kernel: hv_vmbus: registering driver hv_netvsc Sep 4 13:16:37.741605 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 13:16:37.741826 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 13:16:37.751000 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 4 13:16:37.755453 kernel: hv_netvsc f8615163-0000-1000-2000-000d3ade24fb (unnamed net_device) (uninitialized): VF slot 1 added Sep 4 13:16:37.764121 systemd-networkd[584]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 13:16:37.767710 systemd-networkd[584]: eth0: Link UP Sep 4 13:16:37.768002 systemd-networkd[584]: eth0: Gained carrier Sep 4 13:16:37.773533 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 13:16:37.779406 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 13:16:37.779997 systemd-networkd[584]: eth0: DHCPv4 address 10.0.0.5/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 4 13:16:37.799651 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 13:16:37.803097 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 13:16:37.806000 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 4 13:16:37.806000 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 4 13:16:37.811412 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 13:16:37.832315 systemd-vconsole-setup[701]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 4 13:16:37.835266 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 13:16:37.836000 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 4 13:16:37.843956 kernel: nvme nvme0: using unchecked data buffer Sep 4 13:16:37.984658 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - MSFT NVMe Accelerator v1.0 USR-A. Sep 4 13:16:37.990268 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 4 13:16:38.018217 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - MSFT NVMe Accelerator v1.0 EFI-SYSTEM. Sep 4 13:16:38.040604 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - MSFT NVMe Accelerator v1.0 ROOT. Sep 4 13:16:38.053979 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Sep 4 13:16:38.199880 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 4 13:16:38.199000 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 4 13:16:38.201217 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 13:16:38.206185 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 13:16:38.211121 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 13:16:38.219206 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 4 13:16:38.299645 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 4 13:16:38.303000 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 4 13:16:38.449652 systemd[1]: Mounting oem.mount - /oem... Sep 4 13:16:38.480200 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (751) Sep 4 13:16:38.480256 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 18da0a4e-6f54-4a0d-9868-03d8ba28969f Sep 4 13:16:38.483264 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-lib) checksum algorithm Sep 4 13:16:38.543230 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 4 13:16:38.543281 kernel: BTRFS info (device nvme0n1p6): turning on async discard Sep 4 13:16:38.543350 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 4 13:16:38.545506 systemd[1]: Mounted oem.mount - /oem. Sep 4 13:16:38.550278 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 4 13:16:38.773969 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 Sep 4 13:16:38.780654 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 Sep 4 13:16:38.780875 kernel: pci_bus 7870:00: root bus resource [mem 0xfc2000000-0xfc4007fff window] Sep 4 13:16:38.785069 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] Sep 4 13:16:38.793252 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint Sep 4 13:16:38.801993 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref] Sep 4 13:16:38.805371 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref] Sep 4 13:16:38.805470 kernel: pci 7870:00:00.0: enabling Extended Tags Sep 4 13:16:38.844961 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 Sep 4 13:16:38.854965 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref]: assigned Sep 4 13:16:38.855221 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref]: assigned Sep 4 13:16:38.884500 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) Sep 4 13:16:38.895953 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 Sep 4 13:16:38.899121 kernel: hv_netvsc f8615163-0000-1000-2000-000d3ade24fb eth0: VF registering: eth1 Sep 4 13:16:38.899311 kernel: mana 7870:00:00.0 eth1: joined to eth0 Sep 4 13:16:38.906655 systemd-networkd[584]: eth1: Interface name change detected, renamed to enP30832s1. Sep 4 13:16:38.911055 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 Sep 4 13:16:39.003977 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Sep 4 13:16:39.007975 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Sep 4 13:16:39.008507 kernel: hv_netvsc f8615163-0000-1000-2000-000d3ade24fb eth0: Data path switched to VF: enP30832s1 Sep 4 13:16:39.009968 systemd-networkd[584]: enP30832s1: Link UP Sep 4 13:16:39.009976 systemd-networkd[584]: enP30832s1: Gained carrier Sep 4 13:16:39.145143 systemd-networkd[584]: eth0: Gained IPv6LL Sep 4 13:16:39.306493 disk-uuid[715]: Warning: The kernel is still using the old partition table. Sep 4 13:16:39.306493 disk-uuid[715]: The new table will be used at the next reboot or after you Sep 4 13:16:39.306493 disk-uuid[715]: run partprobe(8) or kpartx(8) Sep 4 13:16:39.306493 disk-uuid[715]: The operation has completed successfully. Sep 4 13:16:39.322000 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 4 13:16:39.322000 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 4 13:16:39.318734 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 4 13:16:39.319713 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 4 13:16:39.329044 systemd[1]: Mounting boot.mount - Boot partition... Sep 4 13:16:39.441285 systemd[1]: Mounted boot.mount - Boot partition. Sep 4 13:16:40.254738 ignition[769]: Ignition 2.26.0 Sep 4 13:16:40.254750 ignition[769]: Stage: fetch-offline Sep 4 13:16:40.259847 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 13:16:40.262000 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 4 13:16:40.256072 ignition[769]: no config dir at "/usr/lib/ignition/base.d" Sep 4 13:16:40.265471 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 4 13:16:40.256083 ignition[769]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 13:16:40.256314 ignition[769]: parsed url from cmdline: "" Sep 4 13:16:40.256318 ignition[769]: no config URL provided Sep 4 13:16:40.256325 ignition[769]: reading system config file "/usr/lib/ignition/user.ign" Sep 4 13:16:40.256344 ignition[769]: no config at "/usr/lib/ignition/user.ign" Sep 4 13:16:40.256356 ignition[769]: failed to fetch config: resource requires networking Sep 4 13:16:40.256662 ignition[769]: Ignition finished successfully Sep 4 13:16:40.293837 ignition[800]: Ignition 2.26.0 Sep 4 13:16:40.293841 ignition[800]: Stage: fetch Sep 4 13:16:40.294044 ignition[800]: no config dir at "/usr/lib/ignition/base.d" Sep 4 13:16:40.294049 ignition[800]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 13:16:40.294135 ignition[800]: parsed url from cmdline: "" Sep 4 13:16:40.294137 ignition[800]: no config URL provided Sep 4 13:16:40.294141 ignition[800]: reading system config file "/usr/lib/ignition/user.ign" Sep 4 13:16:40.294146 ignition[800]: no config at "/usr/lib/ignition/user.ign" Sep 4 13:16:40.294160 ignition[800]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Sep 4 13:16:40.461132 ignition[800]: GET result: OK Sep 4 13:16:40.461154 ignition[800]: failed to retrieve userdata from IMDS, falling back to custom data: not a config (empty) Sep 4 13:16:40.481555 ignition[800]: opening config device: "/dev/sr0" Sep 4 13:16:40.481894 ignition[800]: getting drive status for "/dev/sr0" Sep 4 13:16:40.481955 ignition[800]: drive status: OK Sep 4 13:16:40.482054 ignition[800]: mounting config device Sep 4 13:16:40.482062 ignition[800]: op(1): [started] mounting "/dev/sr0" at "/tmp/ignition-azure4242405820" Sep 4 13:16:40.498595 ignition[800]: op(1): [finished] mounting "/dev/sr0" at "/tmp/ignition-azure4242405820" Sep 4 13:16:40.498604 ignition[800]: checking for config drive Sep 4 13:16:40.500714 kernel: UDF-fs: INFO Mounting volume 'UDF Volume', timestamp 2026/09/05 00:00 (1000) Sep 4 13:16:40.500756 ignition[800]: reading config Sep 4 13:16:40.500775 ignition[800]: op(2): [started] unmounting "/dev/sr0" at "/tmp/ignition-azure4242405820" Sep 4 13:16:40.503139 unknown[800]: fetched base config from "system" Sep 4 13:16:40.500853 ignition[800]: op(2): [finished] unmounting "/dev/sr0" at "/tmp/ignition-azure4242405820" Sep 4 13:16:40.503145 unknown[800]: fetched base config from "system" Sep 4 13:16:40.500962 ignition[800]: config has been read from custom data Sep 4 13:16:40.509557 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 4 13:16:40.500970 ignition[800]: parsing config with SHA512: cf83e1357eefb8bdf1542850d66d8007d620e4050b5715dc83f4a921d36ce9ce47d0d13c5d85f2b0ff8318d2877eec2f63b931bd47417a81a538327af927da3e Sep 4 13:16:40.500979 ignition[800]: not a config (empty): provider config was empty, continuing with empty cache config Sep 4 13:16:40.503267 ignition[800]: fetch: fetch complete Sep 4 13:16:40.503283 ignition[800]: fetch: fetch passed Sep 4 13:16:40.503320 ignition[800]: Ignition finished successfully Sep 4 13:16:40.520000 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 4 13:16:40.522963 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 4 13:16:40.543679 ignition[810]: Ignition 2.26.0 Sep 4 13:16:40.543690 ignition[810]: Stage: kargs Sep 4 13:16:40.546771 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 4 13:16:40.549000 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 4 13:16:40.543916 ignition[810]: no config dir at "/usr/lib/ignition/base.d" Sep 4 13:16:40.551960 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 4 13:16:40.543922 ignition[810]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 13:16:40.544421 ignition[810]: kargs: kargs passed Sep 4 13:16:40.544454 ignition[810]: Ignition finished successfully Sep 4 13:16:40.615033 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 4 13:16:40.615134 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 4 13:16:40.618000 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 4 13:16:40.621101 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 4 13:16:40.621000 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 4 13:16:40.621287 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 4 13:16:40.627000 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 4 13:16:40.625558 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 4 13:16:40.625677 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 13:16:40.631608 systemd[1]: Unmounting oem.mount - /oem... Sep 4 13:16:40.647165 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 18da0a4e-6f54-4a0d-9868-03d8ba28969f Sep 4 13:16:40.647670 systemd[1]: oem.mount: Deactivated successfully. Sep 4 13:16:40.650147 systemd[1]: Unmounted oem.mount - /oem. Sep 4 13:16:40.679878 ignition[831]: Ignition 2.26.0 Sep 4 13:16:40.679889 ignition[831]: Stage: disks Sep 4 13:16:40.680161 ignition[831]: no config dir at "/usr/lib/ignition/base.d" Sep 4 13:16:40.680168 ignition[831]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 13:16:40.680654 ignition[831]: disks: disks passed Sep 4 13:16:40.689000 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 4 13:16:40.684903 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 4 13:16:40.680688 ignition[831]: Ignition finished successfully Sep 4 13:16:40.690565 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 4 13:16:40.694738 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 13:16:40.701603 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 13:16:40.702999 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 13:16:40.705982 systemd[1]: Reached target basic.target - Basic System. Sep 4 13:16:40.711838 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 4 13:16:40.901320 systemd-fsck[842]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Sep 4 13:16:40.906506 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 4 13:16:40.909000 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 4 13:16:40.914089 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 4 13:16:41.159991 kernel: EXT4-fs (nvme0n1p9): Supports (experimental) DIO atomic writes awu_min: 4096, awu_max: 4096 Sep 4 13:16:41.312994 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 83882a69-c81a-4be9-891e-8cf8940393b9 r/w with ordered data mode. Quota mode: none. Sep 4 13:16:41.314191 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 4 13:16:41.316663 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 4 13:16:41.322681 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Sep 4 13:16:41.325495 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Sep 4 13:16:41.327523 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 13:16:41.512501 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 4 13:16:41.525166 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 4 13:16:41.528152 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 4 13:16:42.487736 coreos-metadata[854]: Sep 04 13:16:42.487 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Sep 4 13:16:42.492955 coreos-metadata[854]: Sep 04 13:16:42.492 INFO Fetch successful Sep 4 13:16:42.494493 coreos-metadata[854]: Sep 04 13:16:42.493 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Sep 4 13:16:42.502673 coreos-metadata[854]: Sep 04 13:16:42.502 INFO Fetch successful Sep 4 13:16:42.504673 coreos-metadata[854]: Sep 04 13:16:42.502 INFO wrote hostname ci-9999.9.9-l-126a663786 to /sysroot/etc/hostname Sep 4 13:16:42.507933 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 4 13:16:42.509000 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 4 13:16:42.518039 kernel: kauditd_printk_skb: 29 callbacks suppressed Sep 4 13:16:42.518078 kernel: audit: type=1130 audit(1788527802.509:41): 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 4 13:16:43.445971 kernel: loop1: detected capacity change from 0 to 44096 Sep 4 13:16:43.570965 kernel: loop1: p1 p2 p3 Sep 4 13:16:43.882597 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:43.882659 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:43.884184 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:43.885572 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:43.886059 systemd-confext[940]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Sep 4 13:16:43.896970 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:44.053964 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Sep 4 13:16:44.077961 kernel: loop2: detected capacity change from 0 to 44096 Sep 4 13:16:44.083964 kernel: loop2: p1 p2 p3 Sep 4 13:16:44.089521 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:44.089580 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:44.090990 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:44.092270 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:44.092705 (sd-merge)[950]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Sep 4 13:16:44.097063 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:44.114774 (sd-merge)[950]: Using extensions '00-flatcar-default.raw'. Sep 4 13:16:44.116559 (sd-merge)[950]: Merged extensions into '/sysroot/etc'. Sep 4 13:16:44.121049 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Sep 4 13:16:44.122272 initrd-setup-root[957]: /etc 00-flatcar-default Fri 2026-09-04 13:16:36 UTC Sep 4 13:16:44.125445 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 4 13:16:44.127000 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 4 13:16:44.131960 kernel: audit: type=1130 audit(1788527804.127:42): 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 4 13:16:44.133094 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 4 13:16:44.173478 ignition[963]: INFO : Ignition 2.26.0 Sep 4 13:16:44.173478 ignition[963]: INFO : Stage: mount Sep 4 13:16:44.178036 ignition[963]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 4 13:16:44.178036 ignition[963]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 13:16:44.178036 ignition[963]: INFO : mount: mount passed Sep 4 13:16:44.178036 ignition[963]: INFO : Ignition finished successfully Sep 4 13:16:44.177342 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 4 13:16:44.185000 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 4 13:16:44.189955 kernel: audit: type=1130 audit(1788527804.185:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:44.190516 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 4 13:16:44.210613 systemd[1]: Mounting oem.mount - /oem... Sep 4 13:16:44.222967 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (974) Sep 4 13:16:44.225359 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 18da0a4e-6f54-4a0d-9868-03d8ba28969f Sep 4 13:16:44.225404 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-lib) checksum algorithm Sep 4 13:16:44.232055 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 4 13:16:44.232107 kernel: BTRFS info (device nvme0n1p6): turning on async discard Sep 4 13:16:44.233053 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 4 13:16:44.235128 systemd[1]: Mounted oem.mount - /oem. Sep 4 13:16:44.238704 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 13:16:44.253354 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 13:16:44.277646 ignition[994]: INFO : Ignition 2.26.0 Sep 4 13:16:44.277646 ignition[994]: INFO : Stage: files Sep 4 13:16:44.282035 ignition[994]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 4 13:16:44.282035 ignition[994]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 13:16:44.282035 ignition[994]: DEBUG : files: compiled without relabeling support, skipping Sep 4 13:16:44.282035 ignition[994]: INFO : files: createResultFile: createFiles: op(1): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 4 13:16:44.282035 ignition[994]: INFO : files: createResultFile: createFiles: op(1): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 4 13:16:44.282035 ignition[994]: INFO : files: files passed Sep 4 13:16:44.282035 ignition[994]: INFO : Ignition finished successfully Sep 4 13:16:44.282000 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 4 13:16:44.281851 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 4 13:16:44.311562 kernel: audit: type=1130 audit(1788527804.282:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:44.288051 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 4 13:16:44.295027 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 4 13:16:44.301142 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 4 13:16:44.319000 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 4 13:16:44.302772 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 4 13:16:44.319000 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 4 13:16:44.328199 kernel: audit: type=1130 audit(1788527804.319: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 4 13:16:44.328219 kernel: audit: type=1131 audit(1788527804.319:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:44.353389 initrd-setup-root-after-ignition[1024]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 13:16:44.353389 initrd-setup-root-after-ignition[1024]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 4 13:16:44.361187 initrd-setup-root-after-ignition[1028]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 13:16:44.364702 kernel: loop3: detected capacity change from 0 to 44096 Sep 4 13:16:44.364723 kernel: loop3: p1 p2 p3 Sep 4 13:16:44.372590 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:44.372635 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:44.374143 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:44.375363 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:44.375422 systemd-confext[1030]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Sep 4 13:16:44.385986 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:44.399962 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Sep 4 13:16:44.425954 kernel: loop4: detected capacity change from 0 to 44096 Sep 4 13:16:44.427962 kernel: loop4: p1 p2 p3 Sep 4 13:16:44.434969 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:44.440574 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:44.440608 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:44.440620 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:44.443356 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:44.442366 (sd-merge)[1038]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Sep 4 13:16:44.464603 (sd-merge)[1038]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 4 13:16:44.468258 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Sep 4 13:16:44.536959 kernel: loop4: detected capacity change from 0 to 415144 Sep 4 13:16:44.680984 kernel: loop4: p1 p2 p3 Sep 4 13:16:45.130293 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:45.130359 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:45.131964 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:45.133193 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:45.133623 systemd-sysext[1046]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Sep 4 13:16:45.139983 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:45.259959 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 4 13:16:45.555007 kernel: loop5: detected capacity change from 0 to 135456 Sep 4 13:16:45.666967 kernel: loop5: p1 p2 p3 Sep 4 13:16:45.991485 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:45.991546 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:45.992765 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:45.994277 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:45.994312 systemd-sysext[1046]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Sep 4 13:16:45.998766 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:46.140961 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 4 13:16:46.193962 kernel: loop6: detected capacity change from 0 to 168976 Sep 4 13:16:46.255971 kernel: loop6: p1 p2 p3 Sep 4 13:16:46.512627 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:46.512690 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:46.519960 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:46.522115 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:46.522512 systemd-sysext[1046]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Sep 4 13:16:46.535093 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:46.756968 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 4 13:16:46.784977 kernel: loop7: detected capacity change from 0 to 415144 Sep 4 13:16:46.786957 kernel: loop7: p1 p2 p3 Sep 4 13:16:46.793704 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:46.793760 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:46.795338 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:46.796657 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:46.797103 (sd-merge)[1070]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Sep 4 13:16:46.801100 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:46.824963 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 4 13:16:46.826965 kernel: loop1: detected capacity change from 0 to 135456 Sep 4 13:16:46.830206 kernel: loop1: p1 p2 p3 Sep 4 13:16:46.844260 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:46.844295 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:46.846858 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:46.846899 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:46.846957 (sd-merge)[1070]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Sep 4 13:16:46.852993 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:46.873960 kernel: erofs (device dm-3): mounted with root inode @ nid 39. Sep 4 13:16:46.875956 kernel: loop3: detected capacity change from 0 to 168976 Sep 4 13:16:46.881954 kernel: loop3: p1 p2 p3 Sep 4 13:16:46.889363 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:46.889413 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:46.890768 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:46.891893 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:46.891955 (sd-merge)[1070]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Sep 4 13:16:46.896912 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:46.927960 kernel: erofs (device dm-4): mounted with root inode @ nid 39. Sep 4 13:16:46.928147 (sd-merge)[1070]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-9999.9.9+linux-main-6.18-w-nividia-15.raw'. Sep 4 13:16:46.931094 (sd-merge)[1070]: Merged extensions into '/sysroot/usr'. Sep 4 13:16:46.934859 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 13:16:46.936000 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 4 13:16:46.943007 kernel: audit: type=1130 audit(1788527806.936:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:46.943092 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 4 13:16:46.969756 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 4 13:16:46.970853 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 4 13:16:46.973000 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 4 13:16:46.973000 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 4 13:16:46.983114 kernel: audit: type=1130 audit(1788527806.973: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 4 13:16:46.974670 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Sep 4 13:16:46.985679 kernel: audit: type=1131 audit(1788527806.973:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:46.982229 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 4 13:16:46.987717 systemd[1]: Starting dracut-mount.service - dracut mount hook... Sep 4 13:16:47.268954 systemd[1]: Finished dracut-mount.service - dracut mount hook. Sep 4 13:16:47.270000 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 4 13:16:47.276608 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 4 13:16:47.279723 kernel: audit: type=1130 audit(1788527807.270:50): 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 4 13:16:47.299466 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 13:16:47.301000 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 4 13:16:47.305104 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 4 13:16:47.323423 systemd[1]: Stopped target basic.target - Basic System. Sep 4 13:16:47.324198 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 13:16:47.331115 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 4 13:16:47.331353 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 4 13:16:47.339083 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 4 13:16:47.339641 systemd[1]: Stopped target paths.target - Path Units. Sep 4 13:16:47.339957 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 13:16:47.348096 systemd[1]: Stopped target slices.target - Slice Units. Sep 4 13:16:47.348797 systemd[1]: Stopped target sockets.target - Socket Units. Sep 4 13:16:47.354113 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 4 13:16:47.358105 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 4 13:16:47.360984 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Sep 4 13:16:47.366092 systemd[1]: Stopped target swap.target - Swaps. Sep 4 13:16:47.370097 systemd[1]: Stopped target timers.target - Timer Units. Sep 4 13:16:47.370647 systemd[1]: iscsid.socket: Deactivated successfully. Sep 4 13:16:47.370764 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 13:16:47.374491 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 4 13:16:47.374646 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 13:16:47.381517 systemd[1]: systemd-coredump.socket: Deactivated successfully. Sep 4 13:16:47.381623 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Sep 4 13:16:47.385997 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Sep 4 13:16:47.386101 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Sep 4 13:16:47.394000 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 4 13:16:47.393448 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 4 13:16:47.393580 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 13:16:47.397719 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 4 13:16:47.399669 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 13:16:47.405080 systemd[1]: dracut-mount.service: Deactivated successfully. Sep 4 13:16:47.405201 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Sep 4 13:16:47.412000 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 4 13:16:47.414589 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 4 13:16:47.414777 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 4 13:16:47.417000 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 4 13:16:47.420618 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 4 13:16:47.422170 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 4 13:16:47.422517 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 13:16:47.432000 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 4 13:16:47.436000 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 4 13:16:47.427178 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 13:16:47.432068 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 4 13:16:47.432399 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 13:16:47.432892 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 4 13:16:47.433101 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 4 13:16:47.436800 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 4 13:16:47.437002 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 13:16:47.450000 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 4 13:16:47.441024 systemd[1]: ignition-files.service: Deactivated successfully. Sep 4 13:16:47.441161 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 4 13:16:47.455000 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 4 13:16:47.453592 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Sep 4 13:16:47.453722 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 4 13:16:47.460617 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 4 13:16:47.467000 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 4 13:16:47.462394 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 4 13:16:47.462983 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 4 13:16:47.474194 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 4 13:16:47.474317 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 13:16:47.482000 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 4 13:16:47.486335 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 4 13:16:47.486510 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 13:16:47.492265 ignition[1145]: INFO : Ignition 2.26.0 Sep 4 13:16:47.492265 ignition[1145]: INFO : Stage: umount Sep 4 13:16:47.492265 ignition[1145]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 4 13:16:47.492265 ignition[1145]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 13:16:47.492265 ignition[1145]: INFO : umount: umount passed Sep 4 13:16:47.492265 ignition[1145]: INFO : Ignition finished successfully Sep 4 13:16:47.493000 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 4 13:16:47.500000 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 4 13:16:47.496230 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 4 13:16:47.496342 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 13:16:47.513000 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 4 13:16:47.519068 kernel: kauditd_printk_skb: 12 callbacks suppressed Sep 4 13:16:47.508779 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 4 13:16:47.521343 kernel: audit: type=1131 audit(1788527807.513:63): 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 4 13:16:47.510367 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 4 13:16:47.525415 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 4 13:16:47.527017 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 4 13:16:47.530000 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 4 13:16:47.530000 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 4 13:16:47.536362 kernel: audit: type=1130 audit(1788527807.530:64): 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 4 13:16:47.536401 kernel: audit: type=1131 audit(1788527807.530:65): 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 4 13:16:47.538149 systemd[1]: Stopped target network.target - Network. Sep 4 13:16:47.538000 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 4 13:16:47.543000 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 4 13:16:47.550674 kernel: audit: type=1131 audit(1788527807.538:66): 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 4 13:16:47.538733 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 4 13:16:47.552000 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 4 13:16:47.556644 kernel: audit: type=1131 audit(1788527807.543:67): 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 4 13:16:47.538778 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 4 13:16:47.561580 kernel: audit: type=1131 audit(1788527807.552:68): 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 4 13:16:47.544499 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 4 13:16:47.544543 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 4 13:16:47.549566 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 4 13:16:47.549606 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 4 13:16:47.570000 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 4 13:16:47.558405 systemd[1]: Stopping systemd-networkd.service - Network Management... Sep 4 13:16:47.558622 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 4 13:16:47.580553 kernel: audit: type=1131 audit(1788527807.570:69): 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 4 13:16:47.559079 systemd-networkd[584]: eth0: DHCP lease lost Sep 4 13:16:47.565332 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 4 13:16:47.566399 systemd[1]: Stopped systemd-networkd.service - Network Management. Sep 4 13:16:47.580441 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 4 13:16:47.581545 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 4 13:16:47.589000 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 4 13:16:47.593957 kernel: audit: type=1131 audit(1788527807.589:70): 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 4 13:16:47.595000 audit: BPF prog-id=8 op=UNLOAD Sep 4 13:16:47.596814 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 4 13:16:47.595000 audit: BPF prog-id=5 op=UNLOAD Sep 4 13:16:47.606041 kernel: audit: type=1334 audit(1788527807.595:71): prog-id=8 op=UNLOAD Sep 4 13:16:47.598579 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Sep 4 13:16:47.609432 kernel: audit: type=1334 audit(1788527807.595:72): prog-id=5 op=UNLOAD Sep 4 13:16:47.598634 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 4 13:16:47.604152 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 4 13:16:47.604195 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Sep 4 13:16:47.614028 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 4 13:16:47.623012 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 13:16:47.662542 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 4 13:16:47.665704 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 13:16:47.666000 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 4 13:16:47.669548 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 4 13:16:47.669620 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 4 13:16:47.676589 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 4 13:16:47.679000 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 4 13:16:47.676623 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 4 13:16:47.689210 kernel: hv_netvsc f8615163-0000-1000-2000-000d3ade24fb eth0: Data path switched from VF: enP30832s1 Sep 4 13:16:47.687280 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 4 13:16:47.690000 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 4 13:16:47.692996 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Sep 4 13:16:47.687326 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 4 13:16:47.695000 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 4 13:16:47.692889 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 13:16:47.692952 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 13:16:47.702798 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 4 13:16:47.709990 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 4 13:16:47.712000 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 4 13:16:47.710033 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 4 13:16:47.715521 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 4 13:16:47.715565 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 13:16:47.724000 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 4 13:16:47.727277 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 4 13:16:47.727319 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 13:16:47.731000 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 4 13:16:47.735281 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 4 13:16:47.735324 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 13:16:47.737000 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 4 13:16:47.741689 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 13:16:47.743000 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 4 13:16:47.741723 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 13:16:47.747292 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 4 13:16:47.748271 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 4 13:16:47.750000 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 4 13:16:47.753285 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 4 13:16:47.755000 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 4 13:16:47.755000 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 4 13:16:47.754912 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 4 13:16:47.758957 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 4 13:16:47.763664 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 4 13:16:47.779027 systemd[1]: Switching root. Sep 4 13:16:47.964261 systemd-journald[349]: Journal stopped Sep 4 13:16:55.178802 systemd-journald[349]: Received SIGTERM from PID 1 (systemd). Sep 4 13:16:55.178857 kernel: SELinux: policy capability network_peer_controls=1 Sep 4 13:16:55.178878 kernel: SELinux: policy capability open_perms=1 Sep 4 13:16:55.178896 kernel: SELinux: policy capability extended_socket_class=1 Sep 4 13:16:55.178913 kernel: SELinux: policy capability always_check_network=0 Sep 4 13:16:55.178924 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 4 13:16:55.178951 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 4 13:16:55.178969 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 4 13:16:55.178986 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 4 13:16:55.179004 kernel: SELinux: policy capability userspace_initial_context=0 Sep 4 13:16:55.179017 kernel: SELinux: policy capability netlink_xperm=0 Sep 4 13:16:55.179029 kernel: SELinux: policy capability netif_wildcard=0 Sep 4 13:16:55.179044 kernel: SELinux: policy capability genfs_seclabel_wildcard=0 Sep 4 13:16:55.179061 kernel: SELinux: policy capability functionfs_seclabel=0 Sep 4 13:16:55.179079 systemd[1]: Successfully loaded SELinux policy in 250.688ms. Sep 4 13:16:55.179100 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.846ms. Sep 4 13:16:55.179117 systemd[1]: systemd 260.1 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 4 13:16:55.179131 systemd[1]: Detected virtualization microsoft. Sep 4 13:16:55.179149 systemd[1]: Detected architecture x86-64. Sep 4 13:16:55.179163 systemd[1]: Detected first boot. Sep 4 13:16:55.179181 systemd[1]: Initializing machine ID from random generator. Sep 4 13:16:55.179194 systemd[1]: Hostname set to . Sep 4 13:16:55.179213 zram_generator::config[1430]: No configuration found. Sep 4 13:16:55.179237 kernel: Guest personality initialized and is inactive Sep 4 13:16:55.179249 kernel: VMCI host device registered (name=vmci, major=10, minor=259) Sep 4 13:16:55.179263 kernel: Initialized host personality Sep 4 13:16:55.179276 kernel: NET: Registered PF_VSOCK protocol family Sep 4 13:16:55.179292 systemd[1]: Applying preset policy. Sep 4 13:16:55.179304 systemd[1]: Created symlink '/etc/systemd/system/timers.target.wants/google-oslogin-cache.timer' → '/usr/lib/systemd/system/google-oslogin-cache.timer'. Sep 4 13:16:55.179320 systemd[1]: Populated /etc with preset unit settings. Sep 4 13:16:55.179330 kernel: kauditd_printk_skb: 16 callbacks suppressed Sep 4 13:16:55.179344 kernel: audit: type=1334 audit(1788527814.551:89): prog-id=10 op=LOAD Sep 4 13:16:55.179364 kernel: audit: type=1334 audit(1788527814.551:90): prog-id=2 op=UNLOAD Sep 4 13:16:55.179376 kernel: audit: type=1334 audit(1788527814.552:91): prog-id=11 op=LOAD Sep 4 13:16:55.179389 kernel: audit: type=1334 audit(1788527814.552:92): prog-id=12 op=LOAD Sep 4 13:16:55.179405 kernel: audit: type=1334 audit(1788527814.552:93): prog-id=3 op=UNLOAD Sep 4 13:16:55.179419 kernel: audit: type=1334 audit(1788527814.552:94): prog-id=4 op=UNLOAD Sep 4 13:16:55.179429 kernel: audit: type=1334 audit(1788527814.564:95): prog-id=10 op=UNLOAD Sep 4 13:16:55.179445 kernel: audit: type=1131 audit(1788527814.684:96): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:55.179459 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 4 13:16:55.179474 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 4 13:16:55.179487 kernel: audit: type=1130 audit(1788527814.695:97): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:55.179503 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 4 13:16:55.179514 kernel: audit: type=1131 audit(1788527814.695:98): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:55.179530 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 4 13:16:55.179543 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 4 13:16:55.179553 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 4 13:16:55.179565 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 4 13:16:55.179579 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 4 13:16:55.179593 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 4 13:16:55.179606 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 4 13:16:55.179623 systemd[1]: Created slice user.slice - User and Session Slice. Sep 4 13:16:55.179636 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 13:16:55.179652 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 13:16:55.179668 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 4 13:16:55.179682 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 4 13:16:55.179694 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 4 13:16:55.179705 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 13:16:55.179720 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Sep 4 13:16:55.179732 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 4 13:16:55.179748 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 13:16:55.179759 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 13:16:55.179771 systemd[1]: Reached target imports.target - Image Downloads. Sep 4 13:16:55.179785 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 4 13:16:55.179796 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 4 13:16:55.179810 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 4 13:16:55.179822 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 4 13:16:55.179832 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 13:16:55.179842 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 13:16:55.179852 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Sep 4 13:16:55.179865 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Sep 4 13:16:55.179878 systemd[1]: Reached target slices.target - Slice Units. Sep 4 13:16:55.179891 systemd[1]: Reached target swap.target - Swaps. Sep 4 13:16:55.179906 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 4 13:16:55.179917 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 4 13:16:55.179927 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 13:16:55.179957 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 4 13:16:55.179975 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Sep 4 13:16:55.179990 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 4 13:16:55.180002 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Sep 4 13:16:55.180027 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Sep 4 13:16:55.180040 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 4 13:16:55.180054 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Sep 4 13:16:55.180066 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Sep 4 13:16:55.180081 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 4 13:16:55.180097 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Sep 4 13:16:55.180113 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Sep 4 13:16:55.180133 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Sep 4 13:16:55.180152 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Sep 4 13:16:55.180171 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Sep 4 13:16:55.180187 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 13:16:55.180201 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Sep 4 13:16:55.180220 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 4 13:16:55.180236 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 4 13:16:55.180250 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 4 13:16:55.180262 systemd[1]: Mounting media.mount - External Media Directory... Sep 4 13:16:55.180276 systemd[1]: proc-xen.mount - /proc/xen skipped, unmet condition check ConditionVirtualization=xen Sep 4 13:16:55.180287 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 4 13:16:55.180299 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 4 13:16:55.180312 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Sep 4 13:16:55.180332 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 4 13:16:55.180346 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 4 13:16:55.180358 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Sep 4 13:16:55.180370 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 13:16:55.180383 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 4 13:16:55.180403 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 13:16:55.180420 systemd[1]: modprobe@efi_pstore.service - Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore Sep 4 13:16:55.180436 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 4 13:16:55.180452 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Sep 4 13:16:55.180466 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 4 13:16:55.180477 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 4 13:16:55.180494 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 4 13:16:55.180507 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 13:16:55.180527 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 13:16:55.180547 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 4 13:16:55.180563 systemd[1]: Reached target time-set.target - System Time Set. Sep 4 13:16:55.180577 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 4 13:16:55.180590 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 4 13:16:55.180612 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 13:16:55.180646 systemd-journald[1510]: Collecting audit messages is enabled. Sep 4 13:16:55.180677 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer skipped, unmet condition check ConditionVirtualization=xen Sep 4 13:16:55.180697 systemd-journald[1510]: Journal started Sep 4 13:16:55.180724 systemd-journald[1510]: Runtime Journal (/run/log/journal/4aabe35cceeb41828acf02cd09fee15f) is 8M, max 158.5M, 150.5M free. Sep 4 13:16:54.861000 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 4 13:16:55.117000 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 4 13:16:55.120000 audit: BPF prog-id=12 op=UNLOAD Sep 4 13:16:55.120000 audit: BPF prog-id=11 op=UNLOAD Sep 4 13:16:55.120000 audit: BPF prog-id=13 op=LOAD Sep 4 13:16:55.120000 audit: BPF prog-id=14 op=LOAD Sep 4 13:16:55.120000 audit: BPF prog-id=15 op=LOAD Sep 4 13:16:54.429184 systemd[1]: Queued start job for default target multi-user.target. Sep 4 13:16:55.174000 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 4 13:16:55.174000 audit[1510]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=6 a1=7fff1abfec90 a2=4000 a3=0 items=0 ppid=1 pid=1510 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 4 13:16:55.174000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Sep 4 13:16:54.553276 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Sep 4 13:16:54.554357 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 4 13:16:55.182128 systemd-modules-load[1511]: Using 2 probe threads Sep 4 13:16:55.189960 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 13:16:55.192000 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 4 13:16:55.193540 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 4 13:16:55.196097 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 4 13:16:55.199153 systemd[1]: Mounted media.mount - External Media Directory. Sep 4 13:16:55.202138 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 4 13:16:55.205071 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 4 13:16:55.208094 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 4 13:16:55.209711 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 13:16:55.212000 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 4 13:16:55.213333 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 4 13:16:55.214000 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 4 13:16:55.216244 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 4 13:16:55.219000 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 4 13:16:55.225692 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 13:16:55.228357 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Sep 4 13:16:55.242870 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 4 13:16:55.246136 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 4 13:16:55.248741 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Sep 4 13:16:55.253262 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 4 13:16:55.259862 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 13:16:55.263075 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 4 13:16:55.265000 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 4 13:16:55.265000 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 4 13:16:55.263972 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 4 13:16:55.269305 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 4 13:16:55.279000 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 4 13:16:55.278034 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 4 13:16:55.287021 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 13:16:55.291000 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 4 13:16:55.294290 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 4 13:16:55.303077 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 13:16:55.333207 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 4 13:16:55.333980 kernel: fuse: init (API version 7.45) Sep 4 13:16:55.334000 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 4 13:16:55.335410 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 4 13:16:55.335545 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 4 13:16:55.336000 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 4 13:16:55.336000 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 4 13:16:55.337696 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 4 13:16:55.356296 systemd-journald[1510]: Time spent on flushing to /var/log/journal/4aabe35cceeb41828acf02cd09fee15f is 20.632ms for 1197 entries. Sep 4 13:16:55.356296 systemd-journald[1510]: System Journal (/var/log/journal/4aabe35cceeb41828acf02cd09fee15f) is 8M, max 2.2G, 2.2G free. Sep 4 13:16:55.397339 systemd-journald[1510]: Received client request to flush runtime journal. Sep 4 13:16:55.398375 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 4 13:16:55.401000 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 4 13:16:55.402295 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 13:16:55.405000 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 4 13:16:55.411772 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 13:16:55.412000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:55.430436 systemd-tmpfiles[1542]: ACLs are not supported, ignoring. Sep 4 13:16:55.430454 systemd-tmpfiles[1542]: ACLs are not supported, ignoring. Sep 4 13:16:55.432815 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 13:16:55.435000 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 4 13:16:55.623904 kernel: ACPI: bus type drm_connector registered Sep 4 13:16:55.624581 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 13:16:55.624760 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 13:16:55.626000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:55.626000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 13:16:55.629185 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 4 13:16:55.630000 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 4 13:16:55.634290 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 4 13:16:55.691287 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 4 13:16:55.704434 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 4 13:16:55.963428 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 4 13:16:55.963000 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 4 13:16:55.967620 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Sep 4 13:16:55.970000 audit: BPF prog-id=16 op=LOAD Sep 4 13:16:55.971000 audit: BPF prog-id=17 op=LOAD Sep 4 13:16:55.971000 audit: BPF prog-id=18 op=LOAD Sep 4 13:16:55.972830 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Sep 4 13:16:55.974000 audit: BPF prog-id=19 op=LOAD Sep 4 13:16:55.978038 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 13:16:55.982644 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 13:16:55.985076 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 4 13:16:55.992035 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Sep 4 13:16:55.994000 audit: BPF prog-id=20 op=LOAD Sep 4 13:16:55.997000 audit: BPF prog-id=21 op=LOAD Sep 4 13:16:55.997000 audit: BPF prog-id=22 op=LOAD Sep 4 13:16:56.000082 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 4 13:16:56.020724 systemd-tmpfiles[1580]: ACLs are not supported, ignoring. Sep 4 13:16:56.020744 systemd-tmpfiles[1580]: ACLs are not supported, ignoring. Sep 4 13:16:56.023866 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1582 ((systemd-userd)) Sep 4 13:16:56.025166 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Sep 4 13:16:56.030030 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 13:16:56.031000 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 4 13:16:56.033660 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 13:16:56.036311 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Sep 4 13:16:56.036344 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 13:16:56.040078 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Sep 4 13:16:56.043274 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 4 13:16:56.049052 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 4 13:16:56.055029 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Sep 4 13:16:56.058628 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 4 13:16:56.063089 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Sep 4 13:16:56.064096 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Sep 4 13:16:56.111046 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Sep 4 13:16:56.113177 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Sep 4 13:16:56.127555 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Sep 4 13:16:56.134000 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 4 13:16:56.164339 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 4 13:16:56.190339 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 4 13:16:56.189000 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 4 13:16:56.214986 kernel: loop4: detected capacity change from 0 to 44096 Sep 4 13:16:56.218000 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 4 13:16:56.219000 audit: BPF prog-id=23 op=LOAD Sep 4 13:16:56.230000 audit: BPF prog-id=24 op=LOAD Sep 4 13:16:56.231976 kernel: loop4: p1 p2 p3 Sep 4 13:16:56.232101 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 13:16:56.238458 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 4 13:16:56.239091 kernel: tun: Universal TUN/TAP device driver, 1.6 Sep 4 13:16:56.241000 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 4 13:16:56.241684 systemd[1]: modprobe@tun.service: Deactivated successfully. Sep 4 13:16:56.241817 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Sep 4 13:16:56.243000 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 4 13:16:56.243000 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 4 13:16:56.247000 audit: BPF prog-id=25 op=LOAD Sep 4 13:16:56.247000 audit: BPF prog-id=26 op=LOAD Sep 4 13:16:56.247000 audit: BPF prog-id=27 op=LOAD Sep 4 13:16:56.249037 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Sep 4 13:16:56.293796 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:56.293856 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:56.295005 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:56.296622 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:56.297145 systemd-confext[1591]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Sep 4 13:16:56.300567 systemd-nsresourced[1603]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Sep 4 13:16:56.300981 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:56.301571 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Sep 4 13:16:56.303000 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 4 13:16:56.369787 systemd-oomd[1578]: No swap; memory pressure usage will be degraded Sep 4 13:16:56.370499 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Sep 4 13:16:56.371000 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 4 13:16:56.395014 systemd-resolved[1579]: Positive Trust Anchors: Sep 4 13:16:56.395025 systemd-resolved[1579]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 13:16:56.395029 systemd-resolved[1579]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 4 13:16:56.395064 systemd-resolved[1579]: 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 4 13:16:56.496457 systemd-udevd[1600]: Using default interface naming scheme 'v260'. Sep 4 13:16:56.550620 systemd-resolved[1579]: Using system hostname 'ci-9999.9.9-l-126a663786'. Sep 4 13:16:56.551779 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 13:16:56.552000 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 4 13:16:56.553304 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 13:16:56.622920 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 13:16:56.624000 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 4 13:16:56.627000 audit: BPF prog-id=28 op=LOAD Sep 4 13:16:56.629188 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 4 13:16:56.633000 audit: BPF prog-id=7 op=UNLOAD Sep 4 13:16:56.633000 audit: BPF prog-id=6 op=UNLOAD Sep 4 13:16:56.693047 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 4 13:16:56.723591 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 4 13:16:56.742611 systemd-networkd[1617]: lo: Link UP Sep 4 13:16:56.742620 systemd-networkd[1617]: lo: Gained carrier Sep 4 13:16:56.755839 systemd[1]: Started systemd-networkd.service - Network Management. Sep 4 13:16:56.758000 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 4 13:16:56.759129 systemd[1]: Reached target network.target - Network. Sep 4 13:16:56.763185 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 4 13:16:56.767088 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Sep 4 13:16:56.799580 systemd-networkd[1617]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 13:16:56.804973 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Sep 4 13:16:56.810965 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Sep 4 13:16:56.814963 kernel: hv_netvsc f8615163-0000-1000-2000-000d3ade24fb eth0: Data path switched to VF: enP30832s1 Sep 4 13:16:56.817153 systemd-networkd[1617]: enP30832s1: Link UP Sep 4 13:16:56.817163 systemd-networkd[1617]: enP30832s1: Gained carrier Sep 4 13:16:56.817278 systemd-networkd[1617]: eth0: Link UP Sep 4 13:16:56.817287 systemd-networkd[1617]: eth0: Gained carrier Sep 4 13:16:56.824989 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 4 13:16:56.827000 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 4 13:16:56.831996 systemd-networkd[1617]: eth0: DHCPv4 address 10.0.0.5/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 4 13:16:56.849188 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#204 cmd 0x85 status: scsi 0x2 srb 0x6 host 0xc0000001 Sep 4 13:16:56.881955 kernel: hv_vmbus: registering driver hv_balloon Sep 4 13:16:56.884977 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Sep 4 13:16:56.905960 kernel: mousedev: PS/2 mouse device common for all mice Sep 4 13:16:56.933651 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Sep 4 13:16:56.934476 kernel: hyperv_fb: Deprecated: use Hyper-V DRM driver instead Sep 4 13:16:56.934523 kernel: hv_vmbus: registering driver hyperv_fb Sep 4 13:16:56.938960 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Sep 4 13:16:56.939011 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Sep 4 13:16:56.951647 kernel: Console: switching to colour dummy device 80x25 Sep 4 13:16:56.955839 kernel: Console: switching to colour frame buffer device 128x48 Sep 4 13:16:56.986095 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 13:16:57.118007 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Sep 4 13:16:57.177875 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Sep 4 13:16:57.180508 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 4 13:16:57.201972 kernel: kvm_intel: Using Hyper-V Enlightened VMCS Sep 4 13:16:57.204507 kernel: vmentry_ctrl unsupported with eVMCS: 0x100000 Sep 4 13:16:57.204559 kernel: vmexit_ctrl unsupported with eVMCS: 0x10000000 Sep 4 13:16:57.204807 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 13:16:57.206586 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 13:16:57.207000 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 4 13:16:57.207000 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 4 13:16:57.217746 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 13:16:57.226207 kernel: loop4: detected capacity change from 0 to 44096 Sep 4 13:16:57.229361 kernel: loop4: p1 p2 p3 Sep 4 13:16:57.239412 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.239485 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:57.242390 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:57.242438 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:57.242986 (sd-merge)[1702]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Sep 4 13:16:57.246984 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.251910 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 4 13:16:57.254000 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 4 13:16:57.267967 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Sep 4 13:16:57.268045 (sd-merge)[1702]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 4 13:16:57.274461 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Sep 4 13:16:57.273000 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 4 13:16:57.277771 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 4 13:16:57.291995 kernel: loop4: detected capacity change from 0 to 135456 Sep 4 13:16:57.292972 kernel: loop4: p1 p2 p3 Sep 4 13:16:57.312207 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.312260 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:57.313277 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:57.314032 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:57.314102 systemd-sysext[1713]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Sep 4 13:16:57.318060 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.338964 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 4 13:16:57.357969 kernel: loop4: detected capacity change from 0 to 168976 Sep 4 13:16:57.358957 kernel: loop4: p1 p2 p3 Sep 4 13:16:57.364069 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.364133 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:57.365238 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:57.366131 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:57.366360 systemd-sysext[1713]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Sep 4 13:16:57.368211 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.391956 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 4 13:16:57.409958 kernel: loop4: detected capacity change from 0 to 415144 Sep 4 13:16:57.413959 kernel: loop4: p1 p2 p3 Sep 4 13:16:57.420290 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.420335 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:57.421321 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:57.423767 systemd-sysext[1713]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Sep 4 13:16:57.423967 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:57.428981 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.451011 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 4 13:16:57.474960 kernel: loop4: detected capacity change from 0 to 135456 Sep 4 13:16:57.487825 systemd-vconsole-setup[1701]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 4 13:16:57.488432 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 13:16:57.489000 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 4 13:16:57.494961 kernel: loop4: p1 p2 p3 Sep 4 13:16:57.503350 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.503416 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:57.505974 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:57.506024 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:57.507508 (sd-merge)[1735]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Sep 4 13:16:57.509981 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.524964 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 4 13:16:57.526972 kernel: loop5: detected capacity change from 0 to 168976 Sep 4 13:16:57.528963 kernel: loop5: p1 p2 p3 Sep 4 13:16:57.536289 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.536341 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:57.540228 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:57.540280 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:57.540495 (sd-merge)[1735]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Sep 4 13:16:57.542969 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.569971 kernel: erofs (device dm-6): mounted with root inode @ nid 39. Sep 4 13:16:57.572966 kernel: loop6: detected capacity change from 0 to 415144 Sep 4 13:16:57.575063 kernel: loop6: p1 p2 p3 Sep 4 13:16:57.580236 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.580269 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 13:16:57.581086 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Sep 4 13:16:57.581958 kernel: device-mapper: ioctl: error adding target to table Sep 4 13:16:57.581962 (sd-merge)[1735]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Sep 4 13:16:57.583958 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 4 13:16:57.598964 kernel: erofs (device dm-7): mounted with root inode @ nid 39. Sep 4 13:16:57.599976 (sd-merge)[1735]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 4 13:16:57.601546 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 4 13:16:57.604000 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 4 13:16:57.607786 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 13:16:57.638474 systemd-tmpfiles[1759]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 4 13:16:57.638794 systemd-tmpfiles[1759]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 4 13:16:57.639133 systemd-tmpfiles[1759]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 4 13:16:57.640235 systemd-tmpfiles[1759]: ACLs are not supported, ignoring. Sep 4 13:16:57.640376 systemd-tmpfiles[1759]: ACLs are not supported, ignoring. Sep 4 13:16:57.642627 systemd-tmpfiles[1759]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 4 13:16:57.642704 systemd-tmpfiles[1759]: Skipping /boot Sep 4 13:16:57.647371 systemd-tmpfiles[1759]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 4 13:16:57.647438 systemd-tmpfiles[1759]: Skipping /boot Sep 4 13:16:57.656844 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 13:16:57.657000 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 4 13:16:57.659426 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 4 13:16:57.661416 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 4 13:16:57.665475 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 4 13:16:57.672019 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 4 13:16:57.676102 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 4 13:16:57.699000 audit[1768]: AUDIT1127 pid=1768 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 4 13:16:57.706415 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 4 13:16:57.707000 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 4 13:16:57.772744 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 4 13:16:57.774000 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 4 13:16:57.820000 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 4 13:16:57.820000 audit[1792]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff98520f90 a2=420 a3=0 items=0 ppid=1764 pid=1792 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 4 13:16:57.820000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 4 13:16:57.821352 augenrules[1792]: No rules Sep 4 13:16:57.822132 systemd[1]: audit-rules.service: Deactivated successfully. Sep 4 13:16:57.822384 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 4 13:16:58.052174 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 4 13:16:58.056170 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 4 13:16:58.409065 systemd-networkd[1617]: eth0: Gained IPv6LL Sep 4 13:16:58.410523 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Sep 4 13:16:58.413630 systemd[1]: Reached target network-online.target - Network is Online. Sep 4 13:17:04.678020 ldconfig[1766]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 4 13:17:04.688253 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 4 13:17:04.693142 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 4 13:17:04.707562 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 4 13:17:04.709473 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 13:17:04.712114 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 4 13:17:04.713877 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 4 13:17:04.716993 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Sep 4 13:17:04.718634 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 4 13:17:04.720115 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 4 13:17:04.721718 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Sep 4 13:17:04.725051 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Sep 4 13:17:04.726443 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 4 13:17:04.727824 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Sep 4 13:17:04.727854 systemd[1]: Reached target paths.target - Path Units. Sep 4 13:17:04.728805 systemd[1]: Reached target timers.target - Timer Units. Sep 4 13:17:04.732191 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 4 13:17:04.766790 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 13:17:04.769711 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 4 13:17:04.773343 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 4 13:17:04.776259 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 4 13:17:04.779154 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Sep 4 13:17:04.783182 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 4 13:17:04.791575 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 13:17:04.796706 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 13:17:04.800024 systemd[1]: Reached target basic.target - Basic System. Sep 4 13:17:04.803043 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Sep 4 13:17:04.803068 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Sep 4 13:17:04.804668 systemd[1]: Starting chronyd.service - NTP client/server... Sep 4 13:17:04.810031 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 13:17:04.816096 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 4 13:17:04.822890 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 4 13:17:04.825862 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 4 13:17:04.834087 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 4 13:17:04.848028 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Sep 4 13:17:04.849831 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Sep 4 13:17:04.860027 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 4 13:17:04.862126 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Sep 4 13:17:04.863327 chronyd[1808]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Sep 4 13:17:04.887740 jq[1812]: true Sep 4 13:17:04.896463 extend-filesystems[1813]: Found /dev/nvme0n1p6 Sep 4 13:17:04.903178 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Sep 4 13:17:04.904086 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 4 13:17:04.913674 google_oslogin_nss_cache[1814]: oslogin_cache_refresh[1814]: Refreshing passwd entry cache Sep 4 13:17:04.913675 oslogin_cache_refresh[1814]: Refreshing passwd entry cache Sep 4 13:17:04.917841 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 4 13:17:04.920698 KVP[1815]: KVP starting; pid is:1815 Sep 4 13:17:04.929449 KVP[1815]: KVP LIC Version: 3.1 Sep 4 13:17:04.929994 kernel: hv_utils: KVP IC version 4.0 Sep 4 13:17:04.930282 google_oslogin_nss_cache[1814]: oslogin_cache_refresh[1814]: Failure getting users, quitting Sep 4 13:17:04.930347 oslogin_cache_refresh[1814]: Failure getting users, quitting Sep 4 13:17:04.930819 google_oslogin_nss_cache[1814]: oslogin_cache_refresh[1814]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 4 13:17:04.930819 google_oslogin_nss_cache[1814]: oslogin_cache_refresh[1814]: Refreshing group entry cache Sep 4 13:17:04.930368 oslogin_cache_refresh[1814]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 4 13:17:04.930405 oslogin_cache_refresh[1814]: Refreshing group entry cache Sep 4 13:17:04.930929 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 4 13:17:04.941092 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 4 13:17:04.948403 extend-filesystems[1813]: Found /dev/nvme0n1p9 Sep 4 13:17:04.970201 extend-filesystems[1813]: Checking size of /dev/nvme0n1p9 Sep 4 13:17:04.972794 google_oslogin_nss_cache[1814]: oslogin_cache_refresh[1814]: Failure getting groups, quitting Sep 4 13:17:04.972794 google_oslogin_nss_cache[1814]: oslogin_cache_refresh[1814]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 4 13:17:04.957509 oslogin_cache_refresh[1814]: Failure getting groups, quitting Sep 4 13:17:04.972432 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 4 13:17:04.957520 oslogin_cache_refresh[1814]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 4 13:17:04.973470 chronyd[1808]: Timezone right/UTC failed leap second check, ignoring Sep 4 13:17:04.973851 chronyd[1808]: Loaded seccomp filter (level 2) Sep 4 13:17:04.975760 motdgen[1833]: /oem/oem-release: line 2: Azure: command not found Sep 4 13:17:04.977655 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Sep 4 13:17:04.978748 systemd[1]: Starting update-engine.service - Update Engine... Sep 4 13:17:04.985101 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 4 13:17:04.990468 systemd[1]: Started chronyd.service - NTP client/server. Sep 4 13:17:04.994977 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 4 13:17:04.998464 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Sep 4 13:17:04.999429 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Sep 4 13:17:05.003342 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 4 13:17:05.003574 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 4 13:17:05.007130 extend-filesystems[1813]: Resized partition /dev/nvme0n1p9 Sep 4 13:17:05.014551 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 4 13:17:05.022779 systemd[1]: motdgen.service: Deactivated successfully. Sep 4 13:17:05.023054 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 4 13:17:05.030502 jq[1847]: true Sep 4 13:17:05.032086 extend-filesystems[1851]: resize2fs 1.47.4 (6-Mar-2025) Sep 4 13:17:05.037894 jq[1841]: false Sep 4 13:17:05.045345 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 6359552 to 6376955 blocks Sep 4 13:17:05.041514 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Sep 4 13:17:05.065902 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 6376955 Sep 4 13:17:05.065935 update_engine[1835]: I20260904 13:17:05.053126 1835 main.cc:92] Flatcar Update Engine starting Sep 4 13:17:05.041764 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition being skipped. Sep 4 13:17:05.042264 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Sep 4 13:17:05.066646 systemctl[1866]: Created symlink '/etc/systemd/system/multi-user.target.wants/oem-cloudinit.service' → '/usr/lib/systemd/system/oem-cloudinit.service'. Sep 4 13:17:05.066715 systemd[1]: Reload requested from client PID 1866 ('systemctl') (unit enable-oem-cloudinit.service)... Sep 4 13:17:05.066725 systemd[1]: Reloading... Sep 4 13:17:05.088642 extend-filesystems[1851]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Sep 4 13:17:05.088642 extend-filesystems[1851]: old_desc_blocks = 4, new_desc_blocks = 4 Sep 4 13:17:05.088642 extend-filesystems[1851]: The filesystem on /dev/nvme0n1p9 is now 6376955 (4k) blocks long. Sep 4 13:17:05.104497 extend-filesystems[1813]: Resized filesystem in /dev/nvme0n1p9 Sep 4 13:17:05.178350 dbus-daemon[1810]: [system] SELinux support is enabled Sep 4 13:17:05.184332 update_engine[1835]: I20260904 13:17:05.184091 1835 update_check_scheduler.cc:74] Next update check in 11m3s Sep 4 13:17:05.225239 zram_generator::config[1933]: No configuration found. Sep 4 13:17:05.336829 systemd-logind[1831]: New seat seat0. Sep 4 13:17:05.348354 systemd-logind[1831]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 4 13:17:05.545105 sshd_keygen[1844]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Sep 4 13:17:05.602270 systemd[1]: Reloading finished in 535 ms. Sep 4 13:17:05.618804 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 4 13:17:05.623921 dbus-daemon[1810]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 4 13:17:05.624610 systemd[1]: Started systemd-logind.service - User Login Management. Sep 4 13:17:05.626400 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 4 13:17:05.626603 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 4 13:17:05.628681 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 4 13:17:05.658690 systemd[1]: Started update-engine.service - Update Engine. Sep 4 13:17:05.663706 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 4 13:17:05.670142 systemd[1]: Starting oem-cloudinit.service - Run cloudinit... Sep 4 13:17:05.673055 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 4 13:17:05.673479 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 4 13:17:05.675844 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 4 13:17:05.676044 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 4 13:17:05.681269 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Sep 4 13:17:05.686697 bash[2011]: + case azure in Sep 4 13:17:05.686697 bash[2011]: + true Sep 4 13:17:05.688841 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 4 13:17:05.693210 systemd[1]: issuegen.service: Deactivated successfully. Sep 4 13:17:05.693624 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 4 13:17:05.707219 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 4 13:17:05.714284 bash[2024]: ++ case azure in Sep 4 13:17:05.714535 bash[2024]: ++ printf /bin/bash azure Sep 4 13:17:05.714559 bash[2017]: + exec coreos-cloudinit --oem=/bin/bash Sep 4 13:17:05.725536 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 4 13:17:05.728822 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Sep 4 13:17:05.741244 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 4 13:17:05.744836 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 4 13:17:05.746876 systemd[1]: Reached target getty.target - Login Prompts. Sep 4 13:17:05.836082 locksmithd[2014]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 4 13:17:05.878236 bash[2017]: Invalid option to -oem: "/bin/bash". Supported options: ["gce" "azure" "cloudsigma" "vmware" "digitalocean" "ec2-compat"] Sep 4 13:17:05.879115 systemd[1]: oem-cloudinit.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Sep 4 13:17:05.879232 systemd[1]: oem-cloudinit.service: Failed with result 'exit-code'. Sep 4 13:17:05.879579 systemd[1]: Failed to start oem-cloudinit.service - Run cloudinit. Sep 4 13:17:05.882783 systemctl[1866]: Job for oem-cloudinit.service failed because the control process exited with error code. Sep 4 13:17:05.882788 systemctl[1866]: See "systemctl status oem-cloudinit.service" and "journalctl -xeu oem-cloudinit.service" for details. Sep 4 13:17:05.883977 systemd[1]: enable-oem-cloudinit.service: Main process exited, code=exited, status=1/FAILURE Sep 4 13:17:05.884089 systemd[1]: enable-oem-cloudinit.service: Failed with result 'exit-code'. Sep 4 13:17:05.884344 systemd[1]: Failed to start enable-oem-cloudinit.service - Enable cloudinit. Sep 4 13:17:07.971718 containerd[1868]: time="2026-09-04T13:17:07Z" 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 4 13:17:07.971718 containerd[1868]: time="2026-09-04T13:17:07Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="15.874µs" Sep 4 13:17:07.975078 containerd[1868]: time="2026-09-04T13:17:07.975036071Z" level=info msg="starting containerd" revision=aad11006b869517fcd3009450b6f82da282e1a9b version=v2.3.3 Sep 4 13:17:07.975358 containerd[1868]: time="2026-09-04T13:17:07.975328029Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 4 13:17:07.975503 containerd[1868]: time="2026-09-04T13:17:07.975484891Z" level=warning msg="failed check for fsverity support" error="enable fsverity failed: operation not supported" path=/var/lib/containerd/io.containerd.content.v1.content Sep 4 13:17:07.975538 containerd[1868]: time="2026-09-04T13:17:07.975504073Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 4 13:17:07.975538 containerd[1868]: time="2026-09-04T13:17:07.975516531Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 4 13:17:07.975638 containerd[1868]: time="2026-09-04T13:17:07.975625386Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 4 13:17:07.975684 containerd[1868]: time="2026-09-04T13:17:07.975637895Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 4 13:17:07.975684 containerd[1868]: time="2026-09-04T13:17:07.975666676Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Sep 4 13:17:07.975684 containerd[1868]: time="2026-09-04T13:17:07.975676410Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 4 13:17:07.975806 containerd[1868]: time="2026-09-04T13:17:07.975716907Z" 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 4 13:17:07.975806 containerd[1868]: time="2026-09-04T13:17:07.975737084Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 4 13:17:07.976450 containerd[1868]: time="2026-09-04T13:17:07.976163584Z" 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 4 13:17:07.976450 containerd[1868]: time="2026-09-04T13:17:07.976189483Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 4 13:17:07.976450 containerd[1868]: time="2026-09-04T13:17:07.976202063Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 4 13:17:07.976450 containerd[1868]: time="2026-09-04T13:17:07.976213890Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Sep 4 13:17:07.976670 containerd[1868]: time="2026-09-04T13:17:07.976650073Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 4 13:17:07.976732 containerd[1868]: time="2026-09-04T13:17:07.976714348Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 4 13:17:07.976873 containerd[1868]: time="2026-09-04T13:17:07.976860022Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 4 13:17:07.976900 containerd[1868]: time="2026-09-04T13:17:07.976885212Z" 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 4 13:17:07.976924 containerd[1868]: time="2026-09-04T13:17:07.976897578Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 4 13:17:07.978433 containerd[1868]: time="2026-09-04T13:17:07.978392873Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 4 13:17:07.978503 containerd[1868]: time="2026-09-04T13:17:07.978481581Z" level=info msg="metadata content store policy set" policy=shared Sep 4 13:17:07.996424 containerd[1868]: time="2026-09-04T13:17:07.996390588Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 4 13:17:07.996510 containerd[1868]: time="2026-09-04T13:17:07.996455265Z" level=info msg="loading plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Sep 4 13:17:07.996510 containerd[1868]: time="2026-09-04T13:17:07.996472465Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Sep 4 13:17:07.996510 containerd[1868]: time="2026-09-04T13:17:07.996482174Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 4 13:17:07.996510 containerd[1868]: time="2026-09-04T13:17:07.996495549Z" 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 4 13:17:07.996510 containerd[1868]: time="2026-09-04T13:17:07.996505163Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 4 13:17:07.996624 containerd[1868]: time="2026-09-04T13:17:07.996516803Z" 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 4 13:17:07.996624 containerd[1868]: time="2026-09-04T13:17:07.996524798Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 4 13:17:07.996751 containerd[1868]: time="2026-09-04T13:17:07.996723485Z" level=info msg="built-in NRI default validator is disabled" Sep 4 13:17:07.996751 containerd[1868]: time="2026-09-04T13:17:07.996734838Z" level=info msg="runtime interface created" Sep 4 13:17:07.996751 containerd[1868]: time="2026-09-04T13:17:07.996740090Z" level=info msg="created NRI interface" Sep 4 13:17:07.996751 containerd[1868]: time="2026-09-04T13:17:07.996747097Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 4 13:17:07.996840 containerd[1868]: time="2026-09-04T13:17:07.996756915Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 4 13:17:07.996840 containerd[1868]: time="2026-09-04T13:17:07.996770324Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 4 13:17:07.996840 containerd[1868]: time="2026-09-04T13:17:07.996779025Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Sep 4 13:17:08.053332 containerd[1868]: time="2026-09-04T13:17:08.053296465Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Sep 4 13:17:08.053483 containerd[1868]: time="2026-09-04T13:17:08.053461281Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 4 13:17:08.053546 containerd[1868]: time="2026-09-04T13:17:08.053483706Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 4 13:17:08.053546 containerd[1868]: time="2026-09-04T13:17:08.053506171Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 4 13:17:08.053546 containerd[1868]: time="2026-09-04T13:17:08.053528741Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 4 13:17:08.053546 containerd[1868]: time="2026-09-04T13:17:08.053540169Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 4 13:17:08.053647 containerd[1868]: time="2026-09-04T13:17:08.053549867Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 4 13:17:08.053647 containerd[1868]: time="2026-09-04T13:17:08.053559492Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 4 13:17:08.053647 containerd[1868]: time="2026-09-04T13:17:08.053571219Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 4 13:17:08.053723 containerd[1868]: time="2026-09-04T13:17:08.053657999Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 4 13:17:08.053723 containerd[1868]: time="2026-09-04T13:17:08.053681217Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 4 13:17:08.053779 containerd[1868]: time="2026-09-04T13:17:08.053694282Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 4 13:17:08.053779 containerd[1868]: time="2026-09-04T13:17:08.053775136Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 4 13:17:08.053843 containerd[1868]: time="2026-09-04T13:17:08.053784839Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 4 13:17:08.053843 containerd[1868]: time="2026-09-04T13:17:08.053793459Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 4 13:17:08.053843 containerd[1868]: time="2026-09-04T13:17:08.053817839Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 4 13:17:08.053843 containerd[1868]: time="2026-09-04T13:17:08.053827944Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 4 13:17:08.053843 containerd[1868]: time="2026-09-04T13:17:08.053837169Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 4 13:17:08.054020 containerd[1868]: time="2026-09-04T13:17:08.053847400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Sep 4 13:17:08.054020 containerd[1868]: time="2026-09-04T13:17:08.053855855Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 4 13:17:08.054020 containerd[1868]: time="2026-09-04T13:17:08.053865566Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 4 13:17:08.054020 containerd[1868]: time="2026-09-04T13:17:08.053876930Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 4 13:17:08.054020 containerd[1868]: time="2026-09-04T13:17:08.053978406Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 4 13:17:08.054234 containerd[1868]: time="2026-09-04T13:17:08.054219275Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 4 13:17:08.054261 containerd[1868]: time="2026-09-04T13:17:08.054234970Z" level=info msg="Start snapshots syncer" Sep 4 13:17:08.054261 containerd[1868]: time="2026-09-04T13:17:08.054253493Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 4 13:17:08.054993 containerd[1868]: time="2026-09-04T13:17:08.054911196Z" 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,\"statsCollectPeriod\":\"\",\"statsRetentionPeriod\":\"\",\"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 4 13:17:08.055168 containerd[1868]: time="2026-09-04T13:17:08.055005259Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 4 13:17:08.055168 containerd[1868]: time="2026-09-04T13:17:08.055077016Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055311396Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055352865Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055365050Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055374077Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055384703Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055403014Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055413678Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055425282Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055433209Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055439718Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055462380Z" level=info msg="Connect containerd service" Sep 4 13:17:08.055839 containerd[1868]: time="2026-09-04T13:17:08.055500488Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 13:17:08.057138 containerd[1868]: time="2026-09-04T13:17:08.057110533Z" level=warning 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 4 13:17:09.068002 containerd[1868]: time="2026-09-04T13:17:09.067838090Z" level=info msg="loading plugin" id=io.containerd.server.v1.ttrpc type=io.containerd.server.v1 Sep 4 13:17:09.068002 containerd[1868]: time="2026-09-04T13:17:09.067927618Z" level=info msg="Start subscribing containerd event" Sep 4 13:17:09.068002 containerd[1868]: time="2026-09-04T13:17:09.067999921Z" level=info msg="Start stats collector" Sep 4 13:17:09.068002 containerd[1868]: time="2026-09-04T13:17:09.068008438Z" level=info msg="Start recovering state" Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.068095936Z" level=info msg="Start event monitor" Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.068107372Z" level=info msg="Start cni network conf syncer for default" Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.068115824Z" level=info msg="Start streaming server" Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.068125926Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.068133521Z" level=info msg="runtime interface starting up..." Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.068138769Z" level=info msg="starting plugins..." Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.068151294Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.067958352Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.068344072Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-prometheus type=io.containerd.metrics.v1 Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.068376012Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-otel type=io.containerd.metrics.v1 Sep 4 13:17:09.068675 containerd[1868]: time="2026-09-04T13:17:09.068395767Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc type=io.containerd.server.v1 Sep 4 13:17:09.077512 containerd[1868]: time="2026-09-04T13:17:09.077466751Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Sep 4 13:17:09.077512 containerd[1868]: time="2026-09-04T13:17:09.077502577Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Sep 4 13:17:09.077512 containerd[1868]: time="2026-09-04T13:17:09.077512940Z" level=info msg="loading plugin" id=io.containerd.http.v1.pprof type=io.containerd.http.v1 Sep 4 13:17:09.077702 containerd[1868]: time="2026-09-04T13:17:09.077559781Z" level=info msg="loading plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Sep 4 13:17:09.077702 containerd[1868]: time="2026-09-04T13:17:09.077568113Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Sep 4 13:17:09.077702 containerd[1868]: time="2026-09-04T13:17:09.077647126Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 13:17:09.077702 containerd[1868]: time="2026-09-04T13:17:09.077664097Z" level=info msg="starting GRPC server" address=/run/containerd/containerd.sock gid=0 uid=0 Sep 4 13:17:09.077702 containerd[1868]: time="2026-09-04T13:17:09.077694309Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 13:17:09.077870 containerd[1868]: time="2026-09-04T13:17:09.077762350Z" level=info msg="containerd successfully booted in 1.107059s" Sep 4 13:17:09.077978 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 13:17:09.081390 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 4 13:17:09.083162 systemd[1]: Startup finished in 4.345s (kernel) + 14.810s (initrd) + 20.630s (userspace) = 39.787s. Sep 4 13:17:09.531662 login[2029]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Sep 4 13:17:09.560965 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 4 13:17:09.561892 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 4 13:17:09.566382 systemd-logind[1831]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Sep 4 13:17:09.597644 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 4 13:17:09.606229 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 4 13:17:09.774441 login[2030]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Sep 4 13:17:09.783771 systemd-logind[1831]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Sep 4 13:17:09.790135 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 4 13:17:09.883399 waagent[2027]: 2026-09-04T13:17:09.883337Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Sep 4 13:17:09.883834 waagent[2027]: 2026-09-04T13:17:09.883761Z INFO Daemon Daemon OS: flatcar 9999.9.9 Sep 4 13:17:09.883911 waagent[2027]: 2026-09-04T13:17:09.883871Z INFO Daemon Daemon Python: 3.13.14 Sep 4 13:17:09.891971 waagent[2027]: 2026-09-04T13:17:09.884161Z INFO Daemon Daemon Run daemon Sep 4 13:17:09.891971 waagent[2027]: 2026-09-04T13:17:09.884380Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='9999.9.9' Sep 4 13:17:09.891971 waagent[2027]: 2026-09-04T13:17:09.884456Z INFO Daemon Daemon Using waagent for provisioning Sep 4 13:17:09.891971 waagent[2027]: 2026-09-04T13:17:09.884621Z INFO Daemon Daemon Activate resource disk Sep 4 13:17:09.891971 waagent[2027]: 2026-09-04T13:17:09.884694Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Sep 4 13:17:09.891971 waagent[2027]: 2026-09-04T13:17:09.886464Z INFO Daemon Daemon Found device: None Sep 4 13:17:09.891971 waagent[2027]: 2026-09-04T13:17:09.886770Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Sep 4 13:17:09.891971 waagent[2027]: 2026-09-04T13:17:09.887156Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Sep 4 13:17:09.891971 waagent[2027]: 2026-09-04T13:17:09.887780Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 4 13:17:09.891971 waagent[2027]: 2026-09-04T13:17:09.888319Z INFO Daemon Daemon Running default provisioning handler Sep 4 13:17:09.910216 waagent[2027]: 2026-09-04T13:17:09.908691Z 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 4 13:17:09.910549 waagent[2027]: 2026-09-04T13:17:09.910509Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Sep 4 13:17:09.910826 waagent[2027]: 2026-09-04T13:17:09.910797Z INFO Daemon Daemon cloud-init is enabled: False Sep 4 13:17:09.911145 waagent[2027]: 2026-09-04T13:17:09.911120Z INFO Daemon Daemon Copying ovf-env.xml Sep 4 13:17:09.929959 waagent[2027]: 2026-09-04T13:17:09.928557Z INFO Daemon Daemon Successfully mounted dvd Sep 4 13:17:09.979275 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Sep 4 13:17:09.980625 waagent[2027]: 2026-09-04T13:17:09.980584Z INFO Daemon Daemon Detect protocol endpoint Sep 4 13:17:09.981139 waagent[2027]: 2026-09-04T13:17:09.981101Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 4 13:17:09.981445 waagent[2027]: 2026-09-04T13:17:09.981396Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Sep 4 13:17:09.981668 waagent[2027]: 2026-09-04T13:17:09.981647Z INFO Daemon Daemon Test for route to 168.63.129.16 Sep 4 13:17:09.981881 waagent[2027]: 2026-09-04T13:17:09.981857Z INFO Daemon Daemon Route to 168.63.129.16 exists Sep 4 13:17:09.982066 waagent[2027]: 2026-09-04T13:17:09.982044Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Sep 4 13:17:10.014296 waagent[2027]: 2026-09-04T13:17:10.014259Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Sep 4 13:17:10.017960 waagent[2027]: 2026-09-04T13:17:10.015040Z INFO Daemon Daemon Wire protocol version:2012-11-30 Sep 4 13:17:10.017960 waagent[2027]: 2026-09-04T13:17:10.015229Z INFO Daemon Daemon Server preferred version:2015-04-05 Sep 4 13:17:10.097734 waagent[2027]: 2026-09-04T13:17:10.097605Z INFO Daemon Daemon Initializing goal state during protocol detection Sep 4 13:17:10.099358 waagent[2027]: 2026-09-04T13:17:10.099317Z INFO Daemon Daemon Forcing an update of the goal state. Sep 4 13:17:10.106522 waagent[2027]: 2026-09-04T13:17:10.106484Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 4 13:17:10.120806 waagent[2027]: 2026-09-04T13:17:10.120765Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.184 Sep 4 13:17:10.122255 waagent[2027]: 2026-09-04T13:17:10.121755Z INFO Daemon Sep 4 13:17:10.122255 waagent[2027]: 2026-09-04T13:17:10.121854Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 1eb060d1-ef18-467b-9ef0-a2e8fbf97764 eTag: 11442847750835579065 source: Fabric] Sep 4 13:17:10.122255 waagent[2027]: 2026-09-04T13:17:10.122242Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Sep 4 13:17:10.122504 waagent[2027]: 2026-09-04T13:17:10.122475Z INFO Daemon Sep 4 13:17:10.122570 waagent[2027]: 2026-09-04T13:17:10.122548Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Sep 4 13:17:10.130971 waagent[2027]: 2026-09-04T13:17:10.127981Z INFO Daemon Daemon Downloading artifacts profile blob Sep 4 13:17:10.205425 waagent[2027]: 2026-09-04T13:17:10.205376Z INFO Daemon Downloaded certificate {'thumbprint': 'AF7E6BFF6E02F1D6562409F5036488D685404D81', 'hasPrivateKey': True} Sep 4 13:17:10.206657 waagent[2027]: 2026-09-04T13:17:10.206279Z INFO Daemon Fetch goal state completed Sep 4 13:17:10.213506 waagent[2027]: 2026-09-04T13:17:10.213473Z INFO Daemon Daemon Starting provisioning Sep 4 13:17:10.214579 waagent[2027]: 2026-09-04T13:17:10.213779Z INFO Daemon Daemon Handle ovf-env.xml. Sep 4 13:17:10.215228 waagent[2027]: 2026-09-04T13:17:10.214828Z INFO Daemon Daemon Set hostname [ci-9999.9.9-l-126a663786] Sep 4 13:17:10.218012 waagent[2027]: 2026-09-04T13:17:10.217967Z INFO Daemon Daemon Publish hostname [ci-9999.9.9-l-126a663786] Sep 4 13:17:10.219384 waagent[2027]: 2026-09-04T13:17:10.218746Z INFO Daemon Daemon Examine /proc/net/route for primary interface Sep 4 13:17:10.220765 waagent[2027]: 2026-09-04T13:17:10.219512Z INFO Daemon Daemon Primary interface is [eth0] Sep 4 13:17:10.226277 systemd-networkd[1617]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Sep 4 13:17:10.226306 systemd-networkd[1617]: eth0: DHCP lease lost Sep 4 13:17:10.242092 waagent[2027]: 2026-09-04T13:17:10.242045Z INFO Daemon Daemon Create user account if not exists Sep 4 13:17:10.246967 waagent[2027]: 2026-09-04T13:17:10.242393Z INFO Daemon Daemon User core already exists, skip useradd Sep 4 13:17:10.246967 waagent[2027]: 2026-09-04T13:17:10.242496Z INFO Daemon Daemon Configure sudoer Sep 4 13:17:10.246967 waagent[2027]: 2026-09-04T13:17:10.242771Z INFO Daemon Daemon Configure sshd Sep 4 13:17:10.246967 waagent[2027]: 2026-09-04T13:17:10.243003Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Sep 4 13:17:10.246967 waagent[2027]: 2026-09-04T13:17:10.243202Z INFO Daemon Daemon Deploy ssh public key. Sep 4 13:17:10.249227 systemd-networkd[1617]: eth0: DHCPv4 address 10.0.0.5/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 4 13:17:11.384824 waagent[2027]: 2026-09-04T13:17:11.384770Z INFO Daemon Daemon Provisioning complete Sep 4 13:17:11.398398 waagent[2027]: 2026-09-04T13:17:11.398359Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Sep 4 13:17:11.399486 waagent[2027]: 2026-09-04T13:17:11.398693Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Sep 4 13:17:11.399486 waagent[2027]: 2026-09-04T13:17:11.398970Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Sep 4 13:17:11.510195 waagent[2126]: 2026-09-04T13:17:11.510124Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Sep 4 13:17:11.510535 waagent[2126]: 2026-09-04T13:17:11.510237Z INFO ExtHandler ExtHandler OS: flatcar 9999.9.9 Sep 4 13:17:11.510535 waagent[2126]: 2026-09-04T13:17:11.510296Z INFO ExtHandler ExtHandler Python: 3.13.14 Sep 4 13:17:11.510535 waagent[2126]: 2026-09-04T13:17:11.510344Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Sep 4 13:17:11.544577 waagent[2126]: 2026-09-04T13:17:11.544528Z INFO ExtHandler ExtHandler Distro: flatcar-9999.9.9; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.13.14; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Sep 4 13:17:11.544729 waagent[2126]: 2026-09-04T13:17:11.544701Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 4 13:17:11.544805 waagent[2126]: 2026-09-04T13:17:11.544769Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 4 13:17:11.564153 waagent[2126]: 2026-09-04T13:17:11.564107Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 4 13:17:11.613180 waagent[2126]: 2026-09-04T13:17:11.613145Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.184 Sep 4 13:17:11.613581 waagent[2126]: 2026-09-04T13:17:11.613550Z INFO ExtHandler Sep 4 13:17:11.613644 waagent[2126]: 2026-09-04T13:17:11.613620Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 502467af-706c-4af9-8359-940b74dae254 eTag: 11442847750835579065 source: Fabric] Sep 4 13:17:11.613871 waagent[2126]: 2026-09-04T13:17:11.613848Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Sep 4 13:17:11.614279 waagent[2126]: 2026-09-04T13:17:11.614244Z INFO ExtHandler Sep 4 13:17:11.614322 waagent[2126]: 2026-09-04T13:17:11.614299Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Sep 4 13:17:11.618919 waagent[2126]: 2026-09-04T13:17:11.618892Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Sep 4 13:17:11.683718 waagent[2126]: 2026-09-04T13:17:11.683629Z INFO ExtHandler Downloaded certificate {'thumbprint': 'AF7E6BFF6E02F1D6562409F5036488D685404D81', 'hasPrivateKey': True} Sep 4 13:17:11.684088 waagent[2126]: 2026-09-04T13:17:11.684048Z INFO ExtHandler Fetch goal state completed Sep 4 13:17:11.694261 waagent[2126]: 2026-09-04T13:17:11.694213Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.7 9 Jun 2026 (Library: OpenSSL 3.5.7 9 Jun 2026) Sep 4 13:17:11.711401 waagent[2126]: 2026-09-04T13:17:11.711355Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2126 Sep 4 13:17:11.711537 waagent[2126]: 2026-09-04T13:17:11.711509Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Sep 4 13:17:11.711781 waagent[2126]: 2026-09-04T13:17:11.711757Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Sep 4 13:17:11.712889 waagent[2126]: 2026-09-04T13:17:11.712850Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '9999.9.9', '', 'Flatcar Container Linux by Kinvolk'] Sep 4 13:17:11.713211 waagent[2126]: 2026-09-04T13:17:11.713182Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '9999.9.9', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Sep 4 13:17:11.713320 waagent[2126]: 2026-09-04T13:17:11.713297Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Sep 4 13:17:11.713743 waagent[2126]: 2026-09-04T13:17:11.713714Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Sep 4 13:17:11.746171 waagent[2126]: 2026-09-04T13:17:11.746144Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Sep 4 13:17:11.746313 waagent[2126]: 2026-09-04T13:17:11.746288Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Sep 4 13:17:11.751276 waagent[2126]: 2026-09-04T13:17:11.750851Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Sep 4 13:17:11.755700 systemd[1]: Reload requested from client PID 2141 ('systemctl') (unit waagent.service)... Sep 4 13:17:11.755715 systemd[1]: Reloading... Sep 4 13:17:11.834964 zram_generator::config[2189]: No configuration found. Sep 4 13:17:12.064896 systemd[1]: Reloading finished in 308 ms. Sep 4 13:17:12.085860 waagent[2126]: 2026-09-04T13:17:12.085052Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Sep 4 13:17:12.085860 waagent[2126]: 2026-09-04T13:17:12.085211Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Sep 4 13:17:12.701057 waagent[2126]: 2026-09-04T13:17:12.700989Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Sep 4 13:17:12.701416 waagent[2126]: 2026-09-04T13:17:12.701341Z 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 4 13:17:12.702240 waagent[2126]: 2026-09-04T13:17:12.702145Z INFO ExtHandler ExtHandler Starting env monitor service. Sep 4 13:17:12.702240 waagent[2126]: 2026-09-04T13:17:12.702201Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 4 13:17:12.702534 waagent[2126]: 2026-09-04T13:17:12.702489Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Sep 4 13:17:12.702624 waagent[2126]: 2026-09-04T13:17:12.702598Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 4 13:17:12.702982 waagent[2126]: 2026-09-04T13:17:12.702935Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Sep 4 13:17:12.703184 waagent[2126]: 2026-09-04T13:17:12.703159Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 4 13:17:12.703257 waagent[2126]: 2026-09-04T13:17:12.703215Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Sep 4 13:17:12.703385 waagent[2126]: 2026-09-04T13:17:12.703361Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Sep 4 13:17:12.703628 waagent[2126]: 2026-09-04T13:17:12.703597Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 4 13:17:12.703729 waagent[2126]: 2026-09-04T13:17:12.703703Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Sep 4 13:17:12.703850 waagent[2126]: 2026-09-04T13:17:12.703829Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Sep 4 13:17:12.703850 waagent[2126]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Sep 4 13:17:12.703850 waagent[2126]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Sep 4 13:17:12.703850 waagent[2126]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Sep 4 13:17:12.703850 waagent[2126]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Sep 4 13:17:12.703850 waagent[2126]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 4 13:17:12.703850 waagent[2126]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 4 13:17:12.704029 waagent[2126]: 2026-09-04T13:17:12.703987Z INFO EnvHandler ExtHandler Configure routes Sep 4 13:17:12.704076 waagent[2126]: 2026-09-04T13:17:12.704054Z INFO EnvHandler ExtHandler Gateway:None Sep 4 13:17:12.704242 waagent[2126]: 2026-09-04T13:17:12.704221Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Sep 4 13:17:12.704301 waagent[2126]: 2026-09-04T13:17:12.704278Z INFO EnvHandler ExtHandler Routes:None Sep 4 13:17:12.704546 waagent[2126]: 2026-09-04T13:17:12.704514Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Sep 4 13:17:12.712893 waagent[2126]: 2026-09-04T13:17:12.711747Z INFO ExtHandler ExtHandler Sep 4 13:17:12.712893 waagent[2126]: 2026-09-04T13:17:12.711803Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 2d76b2cf-cd43-4928-9cd2-9c81dd7ec567 correlation f63ec62d-150a-4e5f-8a1e-ef04c4939b4b created: 2026-09-04T13:16:04.740440Z] Sep 4 13:17:12.712893 waagent[2126]: 2026-09-04T13:17:12.712059Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Sep 4 13:17:12.712893 waagent[2126]: 2026-09-04T13:17:12.712431Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Sep 4 13:17:12.764578 waagent[2126]: 2026-09-04T13:17:12.764529Z INFO MonitorHandler ExtHandler Network interfaces: Sep 4 13:17:12.764578 waagent[2126]: Executing ['ip', '-a', '-o', 'link']: Sep 4 13:17:12.764578 waagent[2126]: 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 4 13:17:12.764578 waagent[2126]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:de:24:fb brd ff:ff:ff:ff:ff:ff\ alias Network Device\ altname enx000d3ade24fb Sep 4 13:17:12.764578 waagent[2126]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:de:24:fb brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0\ altname enp0s0\ altname ens1 Sep 4 13:17:12.764578 waagent[2126]: Executing ['ip', '-4', '-a', '-o', 'address']: Sep 4 13:17:12.764578 waagent[2126]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Sep 4 13:17:12.764578 waagent[2126]: 2: eth0 inet 10.0.0.5/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Sep 4 13:17:12.764578 waagent[2126]: Executing ['ip', '-6', '-a', '-o', 'address']: Sep 4 13:17:12.764578 waagent[2126]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Sep 4 13:17:12.764578 waagent[2126]: 2: eth0 inet6 fe80::20d:3aff:fede:24fb/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Sep 4 13:17:12.819926 waagent[2126]: 2026-09-04T13:17:12.819883Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 8F831ACA-B6F5-4800-94E1-C6D522FED34F;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Sep 4 13:17:12.942144 waagent[2126]: 2026-09-04T13:17:12.942086Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Sep 4 13:17:12.942144 waagent[2126]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 4 13:17:12.942144 waagent[2126]: pkts bytes target prot opt in out source destination Sep 4 13:17:12.942144 waagent[2126]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 4 13:17:12.942144 waagent[2126]: pkts bytes target prot opt in out source destination Sep 4 13:17:12.942144 waagent[2126]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Sep 4 13:17:12.942144 waagent[2126]: pkts bytes target prot opt in out source destination Sep 4 13:17:12.942144 waagent[2126]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 4 13:17:12.942144 waagent[2126]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 4 13:17:12.942144 waagent[2126]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 4 13:17:12.944780 waagent[2126]: 2026-09-04T13:17:12.944727Z INFO EnvHandler ExtHandler Current Firewall rules: Sep 4 13:17:12.944780 waagent[2126]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 4 13:17:12.944780 waagent[2126]: pkts bytes target prot opt in out source destination Sep 4 13:17:12.944780 waagent[2126]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 4 13:17:12.944780 waagent[2126]: pkts bytes target prot opt in out source destination Sep 4 13:17:12.944780 waagent[2126]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Sep 4 13:17:12.944780 waagent[2126]: pkts bytes target prot opt in out source destination Sep 4 13:17:12.944780 waagent[2126]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 4 13:17:12.944780 waagent[2126]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 4 13:17:12.944780 waagent[2126]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 4 13:17:21.616618 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 4 13:17:21.618212 systemd[1]: Started sshd@0-1-10.0.0.5:22-20.101.212.173:47434.service - OpenSSH per-connection server daemon (20.101.212.173:47434). Sep 4 13:17:21.836158 sshd[2283]: Accepted publickey for core from 20.101.212.173 port 47434 ssh2: RSA SHA256:tlC8WWuyjjK916pzqilWrEYSG5Ww5C5HIZ8yFBOSF7w Sep 4 13:17:21.837288 sshd-session[2283]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 13:17:21.844122 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 4 13:17:21.846836 systemd-logind[1831]: New session '3' of user 'core' with class 'user' and type 'tty'. Sep 4 13:17:21.852679 (systemd)[2287]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Sep 4 13:17:21.854549 systemd-logind[1831]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Sep 4 13:17:22.099178 systemd[2287]: Queued start job for default target default.target. Sep 4 13:17:22.107740 systemd[2287]: Created slice app.slice - User Application Slice. Sep 4 13:17:22.107772 systemd[2287]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Sep 4 13:17:22.107789 systemd[2287]: Reached target machines.target - Virtual Machines and Containers. Sep 4 13:17:22.107830 systemd[2287]: Reached target paths.target - Paths. Sep 4 13:17:22.107854 systemd[2287]: Reached target timers.target - Timers. Sep 4 13:17:22.108833 systemd[2287]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 4 13:17:22.110531 systemd[2287]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 4 13:17:22.110664 systemd[2287]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 4 13:17:22.111638 systemd[2287]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 4 13:17:22.111869 systemd[2287]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 4 13:17:22.112528 systemd[2287]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Sep 4 13:17:22.121644 systemd[2287]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 4 13:17:22.122175 systemd[2287]: Reached target sockets.target - Sockets. Sep 4 13:17:22.124850 systemd[2287]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Sep 4 13:17:22.125033 systemd[2287]: Reached target basic.target - Basic System. Sep 4 13:17:22.125144 systemd[2287]: Reached target default.target - Main User Target. Sep 4 13:17:22.125210 systemd[2287]: Startup finished in 266ms. Sep 4 13:17:22.125633 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 4 13:17:22.135117 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 4 13:17:22.188343 systemd[1]: Started sshd@1-2-10.0.0.5:22-20.101.212.173:47448.service - OpenSSH per-connection server daemon (20.101.212.173:47448). Sep 4 13:17:22.298777 sshd[2301]: Accepted publickey for core from 20.101.212.173 port 47448 ssh2: RSA SHA256:tlC8WWuyjjK916pzqilWrEYSG5Ww5C5HIZ8yFBOSF7w Sep 4 13:17:22.299813 sshd-session[2301]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 13:17:22.304011 systemd-logind[1831]: New session '5' of user 'core' with class 'user' and type 'tty'. Sep 4 13:17:22.308116 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 4 13:17:22.344996 sshd[2305]: Connection closed by 20.101.212.173 port 47448 Sep 4 13:17:22.346128 sshd-session[2301]: pam_unix(sshd:session): session closed for user core Sep 4 13:17:22.348507 systemd[1]: sshd@1-2-10.0.0.5:22-20.101.212.173:47448.service: Deactivated successfully. Sep 4 13:17:22.349935 systemd[1]: session-5.scope: Deactivated successfully. Sep 4 13:17:22.350760 systemd-logind[1831]: Session 5 logged out. Waiting for processes to exit. Sep 4 13:17:22.351919 systemd-logind[1831]: Removed session 5. Sep 4 13:17:22.370287 systemd[1]: Started sshd@2-3-10.0.0.5:22-20.101.212.173:47462.service - OpenSSH per-connection server daemon (20.101.212.173:47462). Sep 4 13:17:22.483892 sshd[2311]: Accepted publickey for core from 20.101.212.173 port 47462 ssh2: RSA SHA256:tlC8WWuyjjK916pzqilWrEYSG5Ww5C5HIZ8yFBOSF7w Sep 4 13:17:22.484398 sshd-session[2311]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 13:17:22.488612 systemd-logind[1831]: New session '6' of user 'core' with class 'user' and type 'tty'. Sep 4 13:17:22.497135 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 4 13:17:22.530285 sshd[2315]: Connection closed by 20.101.212.173 port 47462 Sep 4 13:17:22.531078 sshd-session[2311]: pam_unix(sshd:session): session closed for user core Sep 4 13:17:22.533456 systemd[1]: sshd@2-3-10.0.0.5:22-20.101.212.173:47462.service: Deactivated successfully. Sep 4 13:17:22.535413 systemd[1]: session-6.scope: Deactivated successfully. Sep 4 13:17:22.536111 systemd-logind[1831]: Session 6 logged out. Waiting for processes to exit. Sep 4 13:17:22.537192 systemd-logind[1831]: Removed session 6. Sep 4 13:17:22.558267 systemd[1]: Started sshd@3-4-10.0.0.5:22-20.101.212.173:47464.service - OpenSSH per-connection server daemon (20.101.212.173:47464). Sep 4 13:17:22.668803 sshd[2321]: Accepted publickey for core from 20.101.212.173 port 47464 ssh2: RSA SHA256:tlC8WWuyjjK916pzqilWrEYSG5Ww5C5HIZ8yFBOSF7w Sep 4 13:17:22.669295 sshd-session[2321]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 13:17:22.673006 systemd-logind[1831]: New session '7' of user 'core' with class 'user' and type 'tty'. Sep 4 13:17:22.679103 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 4 13:17:22.714380 sshd[2325]: Connection closed by 20.101.212.173 port 47464 Sep 4 13:17:22.715110 sshd-session[2321]: pam_unix(sshd:session): session closed for user core Sep 4 13:17:22.717262 systemd[1]: sshd@3-4-10.0.0.5:22-20.101.212.173:47464.service: Deactivated successfully. Sep 4 13:17:22.718745 systemd[1]: session-7.scope: Deactivated successfully. Sep 4 13:17:22.719418 systemd-logind[1831]: Session 7 logged out. Waiting for processes to exit. Sep 4 13:17:22.720520 systemd-logind[1831]: Removed session 7. Sep 4 13:17:22.742263 systemd[1]: Started sshd@4-5-10.0.0.5:22-20.101.212.173:47470.service - OpenSSH per-connection server daemon (20.101.212.173:47470). Sep 4 13:17:22.850648 sshd[2331]: Accepted publickey for core from 20.101.212.173 port 47470 ssh2: RSA SHA256:tlC8WWuyjjK916pzqilWrEYSG5Ww5C5HIZ8yFBOSF7w Sep 4 13:17:22.851612 sshd-session[2331]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 13:17:22.855006 systemd-logind[1831]: New session '8' of user 'core' with class 'user' and type 'tty'. Sep 4 13:17:22.860120 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 4 13:17:22.896097 sshd[2335]: Connection closed by 20.101.212.173 port 47470 Sep 4 13:17:22.897075 sshd-session[2331]: pam_unix(sshd:session): session closed for user core Sep 4 13:17:22.899200 systemd[1]: sshd@4-5-10.0.0.5:22-20.101.212.173:47470.service: Deactivated successfully. Sep 4 13:17:22.900583 systemd[1]: session-8.scope: Deactivated successfully. Sep 4 13:17:22.901243 systemd-logind[1831]: Session 8 logged out. Waiting for processes to exit. Sep 4 13:17:22.902375 systemd-logind[1831]: Removed session 8. Sep 4 13:17:22.922388 systemd[1]: Started sshd@5-6-10.0.0.5:22-20.101.212.173:47472.service - OpenSSH per-connection server daemon (20.101.212.173:47472).